builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1472252785.63 results: success (0) buildid: 20160826143002 builduid: d72740f1dd1e45e2bb74bcf3921d96df revision: f1c8f78cd6f6e49a5f67b37567888473b898cb90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:25.626609) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:25.627288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:25.627660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:25.656613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:25.656939) ========= 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-1472250551.177609-1594240334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 16:06:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-08-26 16:06:26 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163168 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:26.023243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:26.023623) ========= 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-1472250551.177609-1594240334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022961 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:26.076814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 16:06:26.077184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1c8f78cd6f6e49a5f67b37567888473b898cb90 --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 f1c8f78cd6f6e49a5f67b37567888473b898cb90 --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-1472250551.177609-1594240334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 16:06:26,647 truncating revision to first 12 chars 2016-08-26 16:06:26,647 Setting DEBUG logging. 2016-08-26 16:06:26,647 attempt 1/10 2016-08-26 16:06:26,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1c8f78cd6f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 16:06:28,042 unpacking tar archive at: fx-team-f1c8f78cd6f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.704133 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 16:06:27.796226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:27.796587) ========= script_repo_revision: f1c8f78cd6f6e49a5f67b37567888473b898cb90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:27.797063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:27.797425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 16:06:27.807157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-26 16:06:27.807531) ========= /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-1472250551.177609-1594240334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:28 INFO - MultiFileLogger online at 20160826 16:06:28 in /builds/slave/test 16:06:28 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 16:06:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:06:28 INFO - {'append_to_log': False, 16:06:28 INFO - 'base_work_dir': '/builds/slave/test', 16:06:28 INFO - 'blob_upload_branch': 'Fx-Team', 16:06:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:06:28 INFO - 'branch': 'Fx-Team', 16:06:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:28 INFO - 'config_files': ('talos/linux_config.py',), 16:06:28 INFO - 'default_actions': ('clobber', 16:06:28 INFO - 'read-buildbot-config', 16:06:28 INFO - 'download-and-extract', 16:06:28 INFO - 'populate-webroot', 16:06:28 INFO - 'create-virtualenv', 16:06:28 INFO - 'install', 16:06:28 INFO - 'run-tests'), 16:06:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:28 INFO - 'download_minidump_stackwalk': True, 16:06:28 INFO - 'download_symbols': 'ondemand', 16:06:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:06:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:06:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:06:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:06:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:28 INFO - 'installer_path': 'installer.exe', 16:06:28 INFO - 'log_level': 'info', 16:06:28 INFO - 'log_name': 'talos', 16:06:28 INFO - 'log_to_console': True, 16:06:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:28 INFO - 'opt_config_files': (), 16:06:28 INFO - 'pip_index': False, 16:06:28 INFO - 'sps_profile': False, 16:06:28 INFO - 'sps_profile_interval': 0, 16:06:28 INFO - 'suite': 'dromaeojs', 16:06:28 INFO - 'system_bits': '32', 16:06:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:28 INFO - 'title': 'talos-linux64-ix-032', 16:06:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:28 INFO - 'use_talos_json': True, 16:06:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:06:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:28 INFO - 'work_dir': 'build'} 16:06:28 INFO - [mozharness: 2016-08-26 23:06:28.474712Z] Running clobber step. 16:06:28 INFO - Running pre-action listener: _resource_record_pre_action 16:06:28 INFO - Running main action method: clobber 16:06:28 INFO - rmtree: /builds/slave/test/build 16:06:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:06:28 INFO - Running post-action listener: _resource_record_post_action 16:06:28 INFO - [mozharness: 2016-08-26 23:06:28.934952Z] Finished clobber step (success) 16:06:28 INFO - [mozharness: 2016-08-26 23:06:28.935055Z] Running read-buildbot-config step. 16:06:28 INFO - Running pre-action listener: _resource_record_pre_action 16:06:28 INFO - Running main action method: read_buildbot_config 16:06:28 INFO - Using buildbot properties: 16:06:28 INFO - { 16:06:28 INFO - "project": "", 16:06:28 INFO - "product": "firefox", 16:06:28 INFO - "script_repo_revision": "production", 16:06:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:06:28 INFO - "repository": "", 16:06:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:06:28 INFO - "buildid": "20160826143002", 16:06:28 INFO - "pgo_build": "True", 16:06:28 INFO - "basedir": "/builds/slave/test", 16:06:28 INFO - "buildnumber": 399, 16:06:28 INFO - "slavename": "talos-linux64-ix-032", 16:06:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:06:28 INFO - "platform": "ubuntu64_hw", 16:06:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:06:28 INFO - "branch": "fx-team", 16:06:28 INFO - "repo_path": "integration/fx-team", 16:06:28 INFO - "revision": "f1c8f78cd6f6e49a5f67b37567888473b898cb90", 16:06:28 INFO - "stage_platform": "linux64-pgo", 16:06:28 INFO - "builduid": "d72740f1dd1e45e2bb74bcf3921d96df", 16:06:28 INFO - "slavebuilddir": "test" 16:06:28 INFO - } 16:06:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:06:28 INFO - Running post-action listener: _resource_record_post_action 16:06:28 INFO - [mozharness: 2016-08-26 23:06:28.937538Z] Finished read-buildbot-config step (success) 16:06:28 INFO - [mozharness: 2016-08-26 23:06:28.937630Z] Running download-and-extract step. 16:06:28 INFO - Running pre-action listener: _resource_record_pre_action 16:06:28 INFO - Running main action method: download_and_extract 16:06:28 INFO - mkdir: /builds/slave/test/build/tests 16:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:28 INFO - trying https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:06:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:29 INFO - Downloaded 1361 bytes. 16:06:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:06:29 INFO - Using the following test package requirements: 16:06:29 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:06:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:06:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:06:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'jsshell-linux-x86_64.zip'], 16:06:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:06:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:06:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:06:29 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:06:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:06:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:06:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:29 INFO - trying https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:06:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:30 INFO - Downloaded 21875218 bytes. 16:06:30 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 16:06:34 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 16:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:34 INFO - trying https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:06:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:35 INFO - Downloaded 21875218 bytes. 16:06:35 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 16:06:40 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')]} 16:06:40 INFO - trying https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:06:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:41 INFO - Downloaded 14413998 bytes. 16:06:41 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 16:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:41 INFO - trying https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:06:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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 16:06:42 INFO - Downloaded 59689673 bytes. 16:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:06:42 INFO - mkdir: /builds/slave/test/properties 16:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 16:06:42 INFO - Contents: 16:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:06:43 INFO - Running post-action listener: _resource_record_post_action 16:06:43 INFO - Running post-action listener: set_extra_try_arguments 16:06:43 INFO - [mozharness: 2016-08-26 23:06:43.575058Z] Finished download-and-extract step (success) 16:06:43 INFO - [mozharness: 2016-08-26 23:06:43.575286Z] Running populate-webroot step. 16:06:43 INFO - Running pre-action listener: _resource_record_pre_action 16:06:43 INFO - Running main action method: populate_webroot 16:06:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:06:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:06:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:06:43 INFO - '--tppagecycles', 16:06:43 INFO - '7'], 16:06:43 INFO - 'tests': ['tsvgm']}}, 16:06:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:06:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:06:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:06:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['damp', 'tps']}, 16:06:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'tests': ['damp', 'tps']}, 16:06:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['dromaeo_dom']}, 16:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:06:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['basic_compositor_video']}, 16:06:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:06:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['a11yr', 16:06:43 INFO - 'ts_paint', 16:06:43 INFO - 'tpaint', 16:06:43 INFO - 'sessionrestore', 16:06:43 INFO - 'sessionrestore_no_auto_restore', 16:06:43 INFO - 'tabpaint']}, 16:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 16:06:43 INFO - 'ts_paint', 16:06:43 INFO - 'tpaint', 16:06:43 INFO - 'sessionrestore', 16:06:43 INFO - 'sessionrestore_no_auto_restore', 16:06:43 INFO - 'tabpaint']}, 16:06:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:06:43 INFO - 'ts_paint', 16:06:43 INFO - 'tpaint', 16:06:43 INFO - 'sessionrestore', 16:06:43 INFO - 'sessionrestore_no_auto_restore', 16:06:43 INFO - 'tabpaint']}, 16:06:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:06:43 INFO - 'ts_paint', 16:06:43 INFO - 'tpaint', 16:06:43 INFO - 'sessionrestore', 16:06:43 INFO - 'sessionrestore_no_auto_restore', 16:06:43 INFO - 'tabpaint']}, 16:06:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['a11yr', 16:06:43 INFO - 'ts_paint', 16:06:43 INFO - 'tpaint', 16:06:43 INFO - 'sessionrestore', 16:06:43 INFO - 'sessionrestore_no_auto_restore', 16:06:43 INFO - 'tabpaint']}, 16:06:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['a11yr', 16:06:43 INFO - 'ts_paint', 16:06:43 INFO - 'tpaint', 16:06:43 INFO - 'sessionrestore', 16:06:43 INFO - 'sessionrestore_no_auto_restore', 16:06:43 INFO - 'tabpaint']}, 16:06:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['tsvgx', 16:06:43 INFO - 'tsvgr_opacity', 16:06:43 INFO - 'tart', 16:06:43 INFO - 'tscrollx', 16:06:43 INFO - 'cart']}, 16:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:06:43 INFO - 'tsvgr_opacity', 16:06:43 INFO - 'tart', 16:06:43 INFO - 'tscrollx', 16:06:43 INFO - 'cart']}, 16:06:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'talos_options': ['--disable-e10s'], 16:06:43 INFO - 'tests': ['tp5o']}, 16:06:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'tests': ['tp5o']}, 16:06:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'talos_options': ['--disable-e10s', 16:06:43 INFO - '--xperf_path', 16:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:43 INFO - 'tests': ['tp5n']}, 16:06:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:43 INFO - 'talos_options': ['--xperf_path', 16:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:43 INFO - 'tests': ['tp5n']}}, 16:06:43 INFO - 'talos.zip': {'path': '', 16:06:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:06:43 INFO - Running post-action listener: _resource_record_post_action 16:06:43 INFO - [mozharness: 2016-08-26 23:06:43.592678Z] Finished populate-webroot step (success) 16:06:43 INFO - [mozharness: 2016-08-26 23:06:43.592769Z] Running create-virtualenv step. 16:06:43 INFO - Running pre-action listener: _resource_record_pre_action 16:06:43 INFO - Running main action method: create_virtualenv 16:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 16:06:43 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 16:06:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:06:43 INFO - Using real prefix '/usr' 16:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:06:46 INFO - Installing pip.................done. 16:06:46 INFO - Return code: 0 16:06:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:06:46 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')]} 16:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:46 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')]} 16:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:46 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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:06:46 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 16:06:46 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 16:06:46 INFO - Using env: {'DISPLAY': ':0', 16:06:46 INFO - 'HOME': '/home/cltbld', 16:06:46 INFO - 'LANG': 'en_US.UTF-8', 16:06:46 INFO - 'LANGUAGE': 'en_US:en', 16:06:46 INFO - 'LOGNAME': 'cltbld', 16:06:46 INFO - 'MAIL': '/var/mail/cltbld', 16:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:46 INFO - 'MOZ_NO_REMOTE': '1', 16:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:46 INFO - 'NO_EM_RESTART': '1', 16:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:46 INFO - 'PWD': '/builds/slave/test', 16:06:46 INFO - 'SHELL': '/bin/bash', 16:06:46 INFO - 'SHLVL': '1', 16:06:46 INFO - 'TERM': 'linux', 16:06:46 INFO - 'TMOUT': '86400', 16:06:46 INFO - 'USER': 'cltbld', 16:06:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:46 INFO - '_': '/tools/buildbot/bin/python'} 16:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:46 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 16:06:46 INFO - Cleaning up... 16:06:46 INFO - Return code: 0 16:06:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:06:46 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')]} 16:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:46 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')]} 16:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:46 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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:06:46 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 16:06:46 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 16:06:46 INFO - Using env: {'DISPLAY': ':0', 16:06:46 INFO - 'HOME': '/home/cltbld', 16:06:46 INFO - 'LANG': 'en_US.UTF-8', 16:06:46 INFO - 'LANGUAGE': 'en_US:en', 16:06:46 INFO - 'LOGNAME': 'cltbld', 16:06:46 INFO - 'MAIL': '/var/mail/cltbld', 16:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:46 INFO - 'MOZ_NO_REMOTE': '1', 16:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:46 INFO - 'NO_EM_RESTART': '1', 16:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:46 INFO - 'PWD': '/builds/slave/test', 16:06:46 INFO - 'SHELL': '/bin/bash', 16:06:46 INFO - 'SHLVL': '1', 16:06:46 INFO - 'TERM': 'linux', 16:06:46 INFO - 'TMOUT': '86400', 16:06:46 INFO - 'USER': 'cltbld', 16:06:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:46 INFO - '_': '/tools/buildbot/bin/python'} 16:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:46 INFO - Downloading/unpacking psutil>=3.1.1 16:06:46 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 16:06:46 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 16:06:46 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 16:06:46 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 16:06:46 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 16:06:46 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 16:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:48 INFO - Installing collected packages: psutil 16:06:48 INFO - Running setup.py install for psutil 16:06:48 INFO - building 'psutil._psutil_linux' extension 16:06:48 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 16:06:48 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 16:06:48 INFO - building 'psutil._psutil_posix' extension 16:06:48 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 16:06:48 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 16:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:49 INFO - Successfully installed psutil 16:06:49 INFO - Cleaning up... 16:06:49 INFO - Return code: 0 16:06:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:06: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 mozsystemmonitor==0.3 16:06:49 INFO - Using env: {'DISPLAY': ':0', 16:06:49 INFO - 'HOME': '/home/cltbld', 16:06:49 INFO - 'LANG': 'en_US.UTF-8', 16:06:49 INFO - 'LANGUAGE': 'en_US:en', 16:06:49 INFO - 'LOGNAME': 'cltbld', 16:06:49 INFO - 'MAIL': '/var/mail/cltbld', 16:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:49 INFO - 'MOZ_NO_REMOTE': '1', 16:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:49 INFO - 'NO_EM_RESTART': '1', 16:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:49 INFO - 'PWD': '/builds/slave/test', 16:06:49 INFO - 'SHELL': '/bin/bash', 16:06:49 INFO - 'SHLVL': '1', 16:06:49 INFO - 'TERM': 'linux', 16:06:49 INFO - 'TMOUT': '86400', 16:06:49 INFO - 'USER': 'cltbld', 16:06:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:49 INFO - '_': '/tools/buildbot/bin/python'} 16:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:06:51 INFO - Installing collected packages: mozsystemmonitor 16:06:51 INFO - Running setup.py install for mozsystemmonitor 16:06:51 INFO - Successfully installed mozsystemmonitor 16:06:51 INFO - Cleaning up... 16:06:51 INFO - Return code: 0 16:06:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:51 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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:06:51 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 16:06:51 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 16:06:51 INFO - Using env: {'DISPLAY': ':0', 16:06:51 INFO - 'HOME': '/home/cltbld', 16:06:51 INFO - 'LANG': 'en_US.UTF-8', 16:06:51 INFO - 'LANGUAGE': 'en_US:en', 16:06:51 INFO - 'LOGNAME': 'cltbld', 16:06:51 INFO - 'MAIL': '/var/mail/cltbld', 16:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:51 INFO - 'MOZ_NO_REMOTE': '1', 16:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:51 INFO - 'NO_EM_RESTART': '1', 16:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:51 INFO - 'PWD': '/builds/slave/test', 16:06:51 INFO - 'SHELL': '/bin/bash', 16:06:51 INFO - 'SHLVL': '1', 16:06:51 INFO - 'TERM': 'linux', 16:06:51 INFO - 'TMOUT': '86400', 16:06:51 INFO - 'USER': 'cltbld', 16:06:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:51 INFO - '_': '/tools/buildbot/bin/python'} 16:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:51 INFO - Downloading/unpacking jsonschema==2.5.1 16:06:51 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 16:06:51 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 16:06:51 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 16:06:51 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 16:06:51 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 16:06:51 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 16:06:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:06:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:06:53 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 16:06:53 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 16:06:53 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 16:06:53 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 16:06:53 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 16:06:53 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 16:06:53 INFO - Downloading functools32-3.2.3-2.tar.gz 16:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:06:53 INFO - warning: no files found matching '*.txt' 16:06:53 INFO - no previously-included directories found matching 'build' 16:06:53 INFO - no previously-included directories found matching 'dist' 16:06:53 INFO - no previously-included directories found matching '.git*' 16:06:53 INFO - Installing collected packages: jsonschema, functools32 16:06:53 INFO - Running setup.py install for functools32 16:06:54 INFO - warning: no files found matching '*.txt' 16:06:54 INFO - no previously-included directories found matching 'build' 16:06:54 INFO - no previously-included directories found matching 'dist' 16:06:54 INFO - no previously-included directories found matching '.git*' 16:06:54 INFO - Successfully installed jsonschema functools32 16:06:54 INFO - Cleaning up... 16:06:54 INFO - Return code: 0 16:06:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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', '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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:06: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:06: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 functools32==3.2.3-2 16:06:54 INFO - Using env: {'DISPLAY': ':0', 16:06:54 INFO - 'HOME': '/home/cltbld', 16:06:54 INFO - 'LANG': 'en_US.UTF-8', 16:06:54 INFO - 'LANGUAGE': 'en_US:en', 16:06:54 INFO - 'LOGNAME': 'cltbld', 16:06:54 INFO - 'MAIL': '/var/mail/cltbld', 16:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:54 INFO - 'MOZ_NO_REMOTE': '1', 16:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:54 INFO - 'NO_EM_RESTART': '1', 16:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:54 INFO - 'PWD': '/builds/slave/test', 16:06:54 INFO - 'SHELL': '/bin/bash', 16:06:54 INFO - 'SHLVL': '1', 16:06:54 INFO - 'TERM': 'linux', 16:06:54 INFO - 'TMOUT': '86400', 16:06:54 INFO - 'USER': 'cltbld', 16:06:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:54 INFO - '_': '/tools/buildbot/bin/python'} 16:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:06:54 INFO - Cleaning up... 16:06:54 INFO - Return code: 0 16:06:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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', '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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:06: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:06: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 blobuploader==1.2.4 16:06:54 INFO - Using env: {'DISPLAY': ':0', 16:06:54 INFO - 'HOME': '/home/cltbld', 16:06:54 INFO - 'LANG': 'en_US.UTF-8', 16:06:54 INFO - 'LANGUAGE': 'en_US:en', 16:06:54 INFO - 'LOGNAME': 'cltbld', 16:06:54 INFO - 'MAIL': '/var/mail/cltbld', 16:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:54 INFO - 'MOZ_NO_REMOTE': '1', 16:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:54 INFO - 'NO_EM_RESTART': '1', 16:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:54 INFO - 'PWD': '/builds/slave/test', 16:06:54 INFO - 'SHELL': '/bin/bash', 16:06:54 INFO - 'SHLVL': '1', 16:06:54 INFO - 'TERM': 'linux', 16:06:54 INFO - 'TMOUT': '86400', 16:06:54 INFO - 'USER': 'cltbld', 16:06:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:54 INFO - '_': '/tools/buildbot/bin/python'} 16:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:06:54 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 16:06:54 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 16:06:54 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 16:06:54 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 16:06:54 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 16:06:54 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 16:06:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:06:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:06:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06:57 INFO - Downloading docopt-0.6.1.tar.gz 16:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:06:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:06:57 INFO - Running setup.py install for blobuploader 16:06:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:06:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:06:57 INFO - Running setup.py install for requests 16:06:57 INFO - Running setup.py install for docopt 16:06:57 INFO - Successfully installed blobuploader requests docopt 16:06:57 INFO - Cleaning up... 16:06:57 INFO - Return code: 0 16:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:57 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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:06:57 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 16:06:57 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 16:06:57 INFO - Using env: {'DISPLAY': ':0', 16:06:57 INFO - 'HOME': '/home/cltbld', 16:06:57 INFO - 'LANG': 'en_US.UTF-8', 16:06:57 INFO - 'LANGUAGE': 'en_US:en', 16:06:57 INFO - 'LOGNAME': 'cltbld', 16:06:57 INFO - 'MAIL': '/var/mail/cltbld', 16:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:57 INFO - 'MOZ_NO_REMOTE': '1', 16:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:57 INFO - 'NO_EM_RESTART': '1', 16:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:57 INFO - 'PWD': '/builds/slave/test', 16:06:57 INFO - 'SHELL': '/bin/bash', 16:06:57 INFO - 'SHLVL': '1', 16:06:57 INFO - 'TERM': 'linux', 16:06:57 INFO - 'TMOUT': '86400', 16:06:57 INFO - 'USER': 'cltbld', 16:06:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:57 INFO - '_': '/tools/buildbot/bin/python'} 16:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:57 INFO - Running setup.py (path:/tmp/pip-Il0W1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:58 INFO - Running setup.py (path:/tmp/pip-4bZaxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:58 INFO - Running setup.py (path:/tmp/pip-Ej3XBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:58 INFO - Running setup.py (path:/tmp/pip-B1yz06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:58 INFO - Running setup.py (path:/tmp/pip-LrvH6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:58 INFO - Running setup.py (path:/tmp/pip-Jjgsq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:58 INFO - Running setup.py (path:/tmp/pip-8zLsr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:58 INFO - Running setup.py (path:/tmp/pip-jreNPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:58 INFO - Running setup.py (path:/tmp/pip-88BDUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:58 INFO - Running setup.py (path:/tmp/pip-lHU7pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:58 INFO - Running setup.py (path:/tmp/pip-twAiU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:58 INFO - Running setup.py (path:/tmp/pip-ik_95h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:58 INFO - Running setup.py (path:/tmp/pip-9dz57T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:58 INFO - Running setup.py (path:/tmp/pip-nrvUAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:58 INFO - Running setup.py (path:/tmp/pip-qVJSLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:59 INFO - Running setup.py (path:/tmp/pip-1ORVYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:59 INFO - Running setup.py (path:/tmp/pip-0racgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:06:59 INFO - Running setup.py install for manifestparser 16:06:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:06:59 INFO - Running setup.py install for mozcrash 16:06:59 INFO - Running setup.py install for mozdebug 16:06:59 INFO - Running setup.py install for mozdevice 16:06:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:06:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:06:59 INFO - Running setup.py install for mozfile 16:06:59 INFO - Running setup.py install for mozhttpd 16:06:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:06:59 INFO - Running setup.py install for mozinfo 16:06:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:06:59 INFO - Running setup.py install for mozInstall 16:07:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Running setup.py install for mozleak 16:07:00 INFO - Running setup.py install for mozlog 16:07:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Running setup.py install for moznetwork 16:07:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Running setup.py install for mozprocess 16:07:00 INFO - Running setup.py install for mozprofile 16:07:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Running setup.py install for mozrunner 16:07:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Running setup.py install for mozscreenshot 16:07:00 INFO - Running setup.py install for moztest 16:07:00 INFO - Running setup.py install for mozversion 16:07:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:00 INFO - Cleaning up... 16:07:01 INFO - Return code: 0 16:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:01 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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:07:01 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 16:07:01 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 16:07:01 INFO - Using env: {'DISPLAY': ':0', 16:07:01 INFO - 'HOME': '/home/cltbld', 16:07:01 INFO - 'LANG': 'en_US.UTF-8', 16:07:01 INFO - 'LANGUAGE': 'en_US:en', 16:07:01 INFO - 'LOGNAME': 'cltbld', 16:07:01 INFO - 'MAIL': '/var/mail/cltbld', 16:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:01 INFO - 'MOZ_NO_REMOTE': '1', 16:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:01 INFO - 'NO_EM_RESTART': '1', 16:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:01 INFO - 'PWD': '/builds/slave/test', 16:07:01 INFO - 'SHELL': '/bin/bash', 16:07:01 INFO - 'SHLVL': '1', 16:07:01 INFO - 'TERM': 'linux', 16:07:01 INFO - 'TMOUT': '86400', 16:07:01 INFO - 'USER': 'cltbld', 16:07:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:01 INFO - '_': '/tools/buildbot/bin/python'} 16:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:01 INFO - Running setup.py (path:/tmp/pip-PmF7BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:01 INFO - Running setup.py (path:/tmp/pip-HSctb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:01 INFO - Running setup.py (path:/tmp/pip-BycAgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:01 INFO - Running setup.py (path:/tmp/pip-yDN4Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:01 INFO - Running setup.py (path:/tmp/pip-jDkGjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:01 INFO - Running setup.py (path:/tmp/pip-ph1voI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:01 INFO - Running setup.py (path:/tmp/pip-H4KP42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:01 INFO - Running setup.py (path:/tmp/pip-rJjaYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:01 INFO - Running setup.py (path:/tmp/pip-a3fsDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:01 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)) 16:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:01 INFO - Running setup.py (path:/tmp/pip-C6jH67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:02 INFO - Running setup.py (path:/tmp/pip-iZJ1Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:02 INFO - Running setup.py (path:/tmp/pip-bEJDQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:02 INFO - Running setup.py (path:/tmp/pip-3CPStl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:02 INFO - Running setup.py (path:/tmp/pip-77ySfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:02 INFO - Running setup.py (path:/tmp/pip-J7eQbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:02 INFO - Running setup.py (path:/tmp/pip-CxA7XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:02 INFO - Running setup.py (path:/tmp/pip-AKIKVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:02 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)) 16:07:02 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)) 16:07:02 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)) 16:07:02 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)) 16:07:02 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)) 16:07:02 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)) 16:07:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:02 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 16:07:02 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 16:07:02 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 16:07:02 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 16:07:02 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 16:07:02 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 16:07:04 INFO - Downloading blessings-1.6.tar.gz 16:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:07:04 INFO - Installing collected packages: blessings 16:07:04 INFO - Running setup.py install for blessings 16:07:04 INFO - Successfully installed blessings 16:07:04 INFO - Cleaning up... 16:07:04 INFO - Return code: 0 16:07:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:04 INFO - Reading from file tmpfile_stdout 16:07:04 INFO - Current package versions: 16:07:04 INFO - argparse == 1.2.1 16:07:04 INFO - blessings == 1.6 16:07:04 INFO - blobuploader == 1.2.4 16:07:04 INFO - docopt == 0.6.1 16:07:04 INFO - functools32 == 3.2.3-2 16:07:04 INFO - jsonschema == 2.5.1 16:07:04 INFO - manifestparser == 1.1 16:07:04 INFO - mozInstall == 1.12 16:07:04 INFO - mozcrash == 0.17 16:07:04 INFO - mozdebug == 0.1 16:07:04 INFO - mozdevice == 0.48 16:07:04 INFO - mozfile == 1.2 16:07:04 INFO - mozhttpd == 0.7 16:07:04 INFO - mozinfo == 0.9 16:07:04 INFO - mozleak == 0.1 16:07:04 INFO - mozlog == 3.3 16:07:04 INFO - moznetwork == 0.27 16:07:04 INFO - mozprocess == 0.23 16:07:04 INFO - mozprofile == 0.28 16:07:04 INFO - mozrunner == 6.12 16:07:04 INFO - mozscreenshot == 0.1 16:07:04 INFO - mozsystemmonitor == 0.3 16:07:04 INFO - moztest == 0.7 16:07:04 INFO - mozversion == 1.4 16:07:04 INFO - psutil == 3.1.1 16:07:04 INFO - requests == 1.2.3 16:07:04 INFO - wsgiref == 0.1.2 16:07:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:04 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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:07:04 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 16:07:04 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 16:07:04 INFO - Using env: {'DISPLAY': ':0', 16:07:04 INFO - 'HOME': '/home/cltbld', 16:07:04 INFO - 'LANG': 'en_US.UTF-8', 16:07:04 INFO - 'LANGUAGE': 'en_US:en', 16:07:04 INFO - 'LOGNAME': 'cltbld', 16:07:04 INFO - 'MAIL': '/var/mail/cltbld', 16:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:04 INFO - 'MOZ_NO_REMOTE': '1', 16:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:04 INFO - 'NO_EM_RESTART': '1', 16:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:04 INFO - 'PWD': '/builds/slave/test', 16:07:04 INFO - 'SHELL': '/bin/bash', 16:07:04 INFO - 'SHLVL': '1', 16:07:04 INFO - 'TERM': 'linux', 16:07:04 INFO - 'TMOUT': '86400', 16:07:04 INFO - 'USER': 'cltbld', 16:07:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:04 INFO - '_': '/tools/buildbot/bin/python'} 16:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 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)) 16:07:05 INFO - Cleaning up... 16:07:05 INFO - Return code: 0 16:07:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:05 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 0x7ffbe6361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd29850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, '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-1472250551.177609-1594240334', '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 16:07:05 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 16:07:05 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 16:07:05 INFO - Using env: {'DISPLAY': ':0', 16:07:05 INFO - 'HOME': '/home/cltbld', 16:07:05 INFO - 'LANG': 'en_US.UTF-8', 16:07:05 INFO - 'LANGUAGE': 'en_US:en', 16:07:05 INFO - 'LOGNAME': 'cltbld', 16:07:05 INFO - 'MAIL': '/var/mail/cltbld', 16:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:05 INFO - 'MOZ_NO_REMOTE': '1', 16:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:05 INFO - 'NO_EM_RESTART': '1', 16:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:05 INFO - 'PWD': '/builds/slave/test', 16:07:05 INFO - 'SHELL': '/bin/bash', 16:07:05 INFO - 'SHLVL': '1', 16:07:05 INFO - 'TERM': 'linux', 16:07:05 INFO - 'TMOUT': '86400', 16:07:05 INFO - 'USER': 'cltbld', 16:07:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:05 INFO - '_': '/tools/buildbot/bin/python'} 16:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:07:05 INFO - Cleaning up... 16:07:05 INFO - Return code: 0 16:07:05 INFO - Running post-action listener: _resource_record_post_action 16:07:05 INFO - Running post-action listener: _start_resource_monitoring 16:07:05 INFO - Starting resource monitoring. 16:07:05 INFO - [mozharness: 2016-08-26 23:07:05.377554Z] Finished create-virtualenv step (success) 16:07:05 INFO - [mozharness: 2016-08-26 23:07:05.378079Z] Running install step. 16:07:05 INFO - Running pre-action listener: _resource_record_pre_action 16:07:05 INFO - Running main action method: install 16:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:05 INFO - Reading from file tmpfile_stdout 16:07:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:07:05 INFO - Reading from file tmpfile_stdout 16:07:05 INFO - Output received: 16:07:05 INFO - Usage: mozinstall [options] installer 16:07:05 INFO - Options: 16:07:05 INFO - -h, --help show this help message and exit 16:07:05 INFO - -d DEST, --destination=DEST 16:07:05 INFO - Directory to install application into. [default: 16:07:05 INFO - "/builds/slave/test"] 16:07:05 INFO - --app=APP Application being installed. [default: firefox] 16:07:05 INFO - mkdir: /builds/slave/test/build/application 16:07:05 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'] 16:07:05 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 16:07:22 INFO - Reading from file tmpfile_stdout 16:07:22 INFO - Output received: 16:07:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:07:22 INFO - Running post-action listener: _resource_record_post_action 16:07:22 INFO - [mozharness: 2016-08-26 23:07:22.714743Z] Finished install step (success) 16:07:22 INFO - [mozharness: 2016-08-26 23:07:22.715023Z] Running run-tests step. 16:07:22 INFO - Running pre-action listener: _resource_record_pre_action 16:07:22 INFO - Running main action method: run_tests 16:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:07:22 INFO - Python 2.7.3 16:07:22 INFO - Return code: 0 16:07:22 INFO - grabbing minidump binary from tooltool 16:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:22 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 0xd24370>, '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 0xd278f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd27d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:07:22 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 16:07:22 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 16:07:22 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 16:07:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:22 INFO - Return code: 0 16:07:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:07:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:07:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:07:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:07:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:07:22 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/Xh5-ZxKERpSBERBG0mSlfw/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 16:07:22 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/Xh5-ZxKERpSBERBG0mSlfw/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 16:07:22 INFO - Using env: {'DISPLAY': ':0', 16:07:22 INFO - 'HOME': '/home/cltbld', 16:07:22 INFO - 'LANG': 'en_US.UTF-8', 16:07:22 INFO - 'LANGUAGE': 'en_US:en', 16:07:22 INFO - 'LOGNAME': 'cltbld', 16:07:22 INFO - 'MAIL': '/var/mail/cltbld', 16:07:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:22 INFO - 'MOZ_NO_REMOTE': '1', 16:07:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:22 INFO - 'NO_EM_RESTART': '1', 16:07:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:22 INFO - 'PWD': '/builds/slave/test', 16:07:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:22 INFO - 'SHELL': '/bin/bash', 16:07:22 INFO - 'SHLVL': '1', 16:07:22 INFO - 'TERM': 'linux', 16:07:22 INFO - 'TMOUT': '86400', 16:07:22 INFO - 'USER': 'cltbld', 16:07:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472250551.177609-1594240334', 16:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:22 INFO - '_': '/tools/buildbot/bin/python'} 16:07:22 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/Xh5-ZxKERpSBERBG0mSlfw/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 16:07:22 INFO - mozversion application_buildid: 20160826143002 16:07:22 INFO - mozversion application_changeset: f1c8f78cd6f6e49a5f67b37567888473b898cb90 16:07:22 INFO - mozversion application_display_name: Nightly 16:07:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:22 INFO - mozversion application_name: Firefox 16:07:22 INFO - mozversion application_remotingname: firefox 16:07:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:07:22 INFO - mozversion application_vendor: Mozilla 16:07:22 INFO - mozversion application_version: 51.0a1 16:07:22 INFO - mozversion platform_buildid: 20160826143002 16:07:22 INFO - mozversion platform_changeset: f1c8f78cd6f6e49a5f67b37567888473b898cb90 16:07:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:07:22 INFO - mozversion platform_version: 51.0a1 16:07:22 INFO - using testdate: 1472252842 16:07:22 INFO - actual date: 1472252842 16:07:22 INFO - starting webserver on 'localhost:53526' 16:07:22 INFO - SUITE-START | Running 2 tests 16:07:22 INFO - TEST-START | dromaeo_css 16:07:22 INFO - operating with platform_type : linux_ 16:07:22 INFO - Initialising browser for dromaeo_css test... 16:07:22 INFO - TEST-INFO | started process 16426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pVkNF/profile http://localhost:53526/getInfo.html) 16:07:27 INFO - PROCESS | 16426 | __metrics Screen width/height:1600/1200 16:07:27 INFO - PROCESS | 16426 | colorDepth:24 16:07:27 INFO - PROCESS | 16426 | Browser inner width/height: 1024/697 16:07:27 INFO - PROCESS | 16426 | __metrics 16:07:28 INFO - PROCESS | 16426 | 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" 16:07:28 INFO - PROCESS | 16426 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:07:29 INFO - PROCESS | 16426 | console.error: PushService: 16:07:29 INFO - PROCESS | 16426 | stateChangeProcessEnqueue: Error transitioning state 16:07:29 INFO - PROCESS | 16426 | UnknownError 16:07:29 INFO - TEST-INFO | 16426: exit 0 16:07:29 INFO - Browser initialized. 16:07:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:07:29 INFO - TEST-INFO | started process 16511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pVkNF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:41 INFO - PROCESS | 16511 | RSS: Main: 179478528 16:07:41 INFO - PROCESS | 16511 | 16:08:33 INFO - PROCESS | 16511 | 1472252913436 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] 16:10:42 INFO - PROCESS | 16511 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53526/tests/dromaeo/cssquery-ext.html) 16:10:43 INFO - PROCESS | 16511 | RSS: Main: 294612992 16:10:43 INFO - PROCESS | 16511 | 16:13:46 INFO - PROCESS | 16511 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-ext.html (next: http://localhost:53526/tests/dromaeo/cssquery-jquery.html) 16:13:47 INFO - PROCESS | 16511 | RSS: Main: 268816384 16:13:47 INFO - PROCESS | 16511 | 16:16:49 INFO - PROCESS | 16511 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53526/tests/dromaeo/cssquery-mootools.html) 16:16:49 INFO - PROCESS | 16511 | RSS: Main: 214470656 16:16:49 INFO - PROCESS | 16511 | 16:19:51 INFO - PROCESS | 16511 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53526/tests/dromaeo/cssquery-prototype.html) 16:19:52 INFO - PROCESS | 16511 | RSS: Main: 214818816 16:19:52 INFO - PROCESS | 16511 | 16:22:55 INFO - PROCESS | 16511 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53526/tests/dromaeo/cssquery-yui.html) 16:22:55 INFO - PROCESS | 16511 | RSS: Main: 217841664 16:22:55 INFO - PROCESS | 16511 | 16:25:58 INFO - PROCESS | 16511 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-yui.html (next: http://localhost:53526/tests/dromaeo/cssquery-dojo.html) 16:25:59 INFO - PROCESS | 16511 | RSS: Main: 293695488 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | __start_tp_report 16:25:59 INFO - PROCESS | 16511 | _x_x_mozilla_page_load 16:25:59 INFO - PROCESS | 16511 | _x_x_mozilla_page_load_details 16:25:59 INFO - PROCESS | 16511 | |i|pagename|runs| 16:25:59 INFO - PROCESS | 16511 | |0;dojo.html;2959.2158078109296;2979.746721528669;2981.746551543119;3009.2176034231093;3028;4998.700077995323;5044.293798868152;5125.8462246132585;5159.509846564575;5204.063268611653;5154.278401023859;5184.040952423804;5235.267062611238;5236.083685355066;5272.051030814452;4686.578207961283;4693.929591056137;4755.262934245197;4764.571188593026;4850.490698476645;4786.2581299898575;4806.807727690888;4819.807207711705;4835.15384807659;4852.708837469745;4652.930206046895;4722.504137065627;4738.763061846928;4769.976150119227;4791.353167322419;4724.385829842133;4735.881602959919;4746.501617330199;4750.50119737426;4852.393450818648;4747.430308363018;4764.166270902613;4769.4515130760055;4770.594499467515;4785.66500344976;5011.674241174312;5068.923966140511;5161.870953226162;5182.818601348935;5196.740162991835;5497.422770609109;5539.975104605661;5540.196671482653;5566.666000040011;5584.972075139598;5534.557235421197;5552;5552.972235138798;5553.194786755938;5574.275344205268;4988.950110498885;5095;5180.274761533426;5190.662606930538;5246.134387826042;5671.602987790898;5673.234113394721;5678;5686.289213848269;5719.399463056402;5434.375046869582;5434.483724046209;5439.972800135974;5443.101888188405;5459.153831156098;5342.332208473941;5469.535089517435;5480.6437581557075;5502.752376143083;5559.33288005442;5439.592030597721;5442.292501974797;5449.6730196188355;5458.235846981426;5462.918056229159;5461.1262198048125;5462.890742185134;5467.371252305956;5471.632091977006;5547.1679248113105;4193.370994350872;4223.113146239262;4232.3016702243785;4256.87229383119;4284.207421627009;3813.618638136164;3852.6917846572205;3869.9613003870163;3896.5324161100284;3921.490206273166;5196.32447781786;5207.3490813648295;5229.058769421541;5239.161734122522;5243.737813109329;5326.041312563698;5495.285612870382;5527.861803454865;5530.419305972815;5589.860253493695;5241.790328386822;5247.763850626731;5266.131088370376;5316.415194328621;5319.361676598833;4803.759812009385;4815.614750819926;4817.614590832725;4820.638452116105;4871.415430148334;5527.640703354349;5676.290463692038;5700.230468886647;5716.971415142898;5721.8569535761935;5552.5280351168985;5575.860603484945;5579.386267510652;5632.633878797865;5635.408282130317;5720.027595308724;5744.0522313817755;5746.9712651436475;5750.6262092963825;5761.164631128379;5280.339957505312;5438.537724293479;5465.344158700981;5466.180072989084;5480.890382192254;5518.530924871431;5582.27430434041;5597.468240517144;5653.038983372919;5659.688717120598;5447.836564903059;5457.508824205841;5469.507744303032;5476.04169270384;5479.123340265538;5225;5315.176147697113;5410.648307860134;5425.701586412627;5430.375506816608;5336.653117547347;5380.031594313061;5386.35363756336;5434.755436005468;5446.400895901527;5342.43904390049;5384.057789886676;5385.676859388449;5387.515123638735;5418.593605479526;5200.817971370984;5247.055530004636;5322.600804939722;5325.2278419628165;5378.6503877249415 16:25:59 INFO - PROCESS | 16511 | |1;ext.html;561.5735739242996;588.6026931821021;597.4772074434869;603.3845477612837;603.5503549855358;31360.68639313606;32164.517532237005;35032.2993540129;35046.649533504686;43676.56323436765;41078.794606027004;44600.776996114975;45277.32084018734;45403.31895021578;45539.77230113853;8956.373053886247;9078.273738100968;9080.500572468512;9099.272058235358;9099.408538444979;8235.794105147359;8902.73291801247;9007.54962251888;9014;10608.257421980465;10794.946025269863;11182.552697892075;11184.888151118506;11186.720331991724;11198.888011119907;10983.286086404398;11044.502997365138;11049.33703977764;11063.446827658585;11064.114870810316;10801.5679372825;10852.511636976355;10874.347539147677;10881.945590272077;10889.292196007234;42897.785511072245;43161.78419107884;43271.10560049579;43291.35062974058;43365.78317108426;3330.7002369786837;3346.6987971082476;3421.7775844570274;3634.3650506781;4099.836006559734;31548;32067.358652827046;32982.50526242084;33705.32589348224;34046.48930266048;4165.58344165584;4223.260929337353;4226.429432026668;4243.745375277463;4317.740935543846;336267;336371;337271;337637;337940.3102984494;58536.4146358531;58865.70567147137;58970.11544826831;59103.11345329823;59159.704201478715;61818.38181618216;61842.690786545776;61933.69033154805;61974.69012654908;61983.690081549306;17064.2321095551;17276.827231727773;17313.53729254129;17328.740068898976;17329.7400538992;12174.14780965324;12191.329476878856;12207.877921220852;12209.206401583868;12250.326232057323;16542.751858722128;17631.206595703225;17680;17688.55778605545;17692.203850826743;6602.801915942529;6638.618511782297;6683.7660681875905;6787.694553745093;6797.150356205474;969.7672558585889;985.1921424431897;995.8058178655237;1032.4785983078648;1053.4679986606714;31436.371272574877;31447.685523144934;31490.89781857624;31576.842115789274;31979.68020319767;946.7633091727068;1074.785042991405;1079.3739631013993;1142.4287856071965;1150.4707834396272;15375.875214910468;16313.91843040801;16325.591860203353;16440.424585139463;16695.74956375655;507207;511371;511624;512675;518499;58098;58187.4181258182;58340.416595834344;58351.41648583545;58540.707296463246;1213.1811027556541;1300.8959283257316;1330.846952600444;1355.8711922367359;1364.2769332253922;30851.537226942062;33035.669643303256;33106.668933311325;33346;33599.49600755942;51052.23421648752;51369.43152842268;51419.74290128675;51617.22574161466;51679.74160129175;389048;390199;391452;392667;392750;27749.861250694426;28975.522937247664;28983.13050608485;30075.699243008166;41870.790646046575;47589.28616070693;47709;47777.522224777305;48051.35717535569;49779.25331119964;40409;40644.187116256915;40655.39016914689;40886.79556602198;41537;39911.006674498945;41025.1794964105;41053.178936421704;41165.79417102895;42699.7865010673;39808;40671.59328406678;40734.18531629292;40805.59194408018;41574.58425415828;33668;35783.82108089443;36276.09309767277;36693.816530917175;36730.5923289207;27362.45275094447;27626.5856012164;27695.72304277012;27815.582766258118;27951.58072628953 16:25:59 INFO - PROCESS | 16511 | |2;jquery.html;372.7707459912155;394.733554850476;408.0879234909976;410.4110601287153;426.7439536278234;13798.793018104723;18421.35525256616;19016.714749278737;19583.608327833434;19607.21571137153;12013.639590812269;12475.875241247584;12516.49934002641;12585.433655485502;12588.18176818506;3978.9801050994706;5280.5247527722495;5410.377806552257;5414.052540805363;5415.783368665248;5654.264945557072;5878.50032747217;5934.851628709273;6027.789027384042;6035.366286539916;5837.445442682938;5985.730642121115;5990.640561566298;5998.9700051499685;6022.217111775463;5976.342602313742;5993.940060599425;5995.250593675791;6008.03871380577;6015.909761353583;5189.299444574972;5466.316710411199;5494.313210848644;5562.137868630369;5793.681347525884;13933.164010159322;14018.579442616738;14180.858191418058;14318.57044288673;14401.20793356365;2209.2488553891594;2230.654248591471;2280.3728974532137;2362.1378196957985;2540.2125341144306;9280.932692740354;9743.366681165702;9834.75413114678;9867;9869.407835529892;1779.1904683369037;1796.8742188046842;1804.3414153833755;1822.7539282197;1834.4404956488265;75222;83181;83949.58025209834;84316.57841710813;84861.15138848595;10887.891121088845;10965.780684386427;11286;11373.147013973985;11435.14236432271;15147.924260378628;15195.696086078438;15196.240187990556;15197;15210.923945380202;8040.195980401913;8109.797255068553;8131.79670508242;8191.221833925768;8417;7671.923280767232;7783.494072885244;7903.170167132484;7975.401844861659;8206.179382061866;4636.165490211794;4678.345031695565;4687.648426367968;4694.108119457293;4923.507649235048;1919.6640587897061;2004.3385682724665;2011.2256781139367;2037.1647624473894;2039.34740882919;838.8951381077366;945.9101385368378;972.863799068131;1030.567161792049;1041.2763129624989;18948.715769263472;19658.311959081362;19673.901630491757;19762.320202782637;19783.01084945747;916.3951791817368;927.6660402255183;938.9718258506924;951.538503825644;961.245422343457;10193;10778.353298802096;10860.511276992554;10950.780984380268;10979.780404391868;476940;477781.44437111757;479706;480847;482948;85404;86303;86403;86761.56619216989;89423;947.4560804240635;967.086103632075;988.4563490080427;988.5106872098357;991.8115558044093;16697.2486238122;17056;17495.737563936807;17501;17798.199081041126;39844;40182.59817401788;40291;40632;41041.58958410378;54246;55017.44982550123;55181.181191123454;56236;57354;8066.314363279187;8259.050209225776;8327.958360208402;8406;8638.136186381564;10762.3542587445;12074.879251207376;13613.455461781417;13659.863401366256;13669.726605467637;11548.653540393801;11707;11728.824067638821;11761.647150585497;11788.469518871843;10875.184361173102;11561.942190288995;11780.52877884875;11911.880881191077;11924.642260732191;11403.201775875608;11629;11990.280583165038;12184;12251.509939602316;8669.869951950852;8733.214010739064;8785.516796575994;8849.380543361904;8970.147835955573;10823;11294.717632059264;11760.882391176321;11854.110941679237;11895.881041189477 16:25:59 INFO - PROCESS | 16511 | |3;mootools.html;1286.4854058376654;1427.5360507834953;1456.3228098933996;1577.329634905165;1765.638044200938;7565.6217189140525;7878.763637090882;7923.524588524685;8113.472624279418;8134.6339414726335;7963.362930965523;8063.717769878055;8076.3942704297115;8076.5154090754595;8078.272955434009;2243.562505311469;2258.3112150794;2259.8644081355087;2260.4122928038746;2269.7503274639776;2229.6209644360497;2263.8302127340435;2297.931062068141;2303.1017903017837;2310.7573704760925;2260.8078313343303;2288.7367952685404;2296.850704704197;2305.204704376987;2305.9192928247517;2188.2013065231154;2199.2522542335523;2210.8784016879067;2210.9166508410844;2214.136486770161;2198.6372248578964;2199.3401979406276;2203.724534433196;2204.7023651806962;2209.591225623265;7887.881681774778;7936.960315198445;7958;7985.480943738638;8032.518048917083;4703.764811759433;4816.133096042711;4825.782839772183;4832.251001094836;4837.1776797944085;3094.9941269087412;3194.1216165554424;3244.7241984431116;3248.187953011747;3256.3812875553567;1095.9232853700244;1103.0623969625753;1112.2659045030323;1126.1272513801869;1147.9311241325463;10709.785804283949;10777.245592808507;10856.511456984455;10862.076723478593;10896.782064358747;3994.420808982681;4106.1582375613525;4112.259793237246;4199.811008504625;4229.97885010573;8617.48295102296;8619.310455163697;8630.050694423608;8652.307815374756;8653.350998675125;4805.399325084364;4807.687500312469;4826.927596086061;4830.637702172351;4831.806727730851;3990.341593637075;4323.3947247385395;4469.061497085583;4548.499665036843;4549.067441174551;3574.249407624376;3588.085038315265;3666.2300916807767;3714.5542534895985;3720.2745464634136;1114.3815182573749;1163.168334640736;1165.155262434728;1170.590293397304;1174.9706257343635;916.6745805239177;923.8845144356956;928.7631653928205;945.4091193004373;983.3608154699359;5423.105187643994;5475.09660905954;5583.637063590853;5621.18492818539;5760.135979603093;413.6256687697638;415.7983378061638;416.8207670701567;420.8905684521985;425.6849931051062;3807.162424266657;3876.96123038766;3893.6301051400637;3926.6073392660505;4014.237294913957;9192.81614367709;9922.454265015349;9976.152027077635;9985.750356241153;10023.448710321003;9904.55429505674;9930.453825039693;9931.255155863339;9953.203743700487;9955.651552195639;7190.209077001526;7389.076365454318;7443.516171448839;7623.580703061274;7627.961860190663;5660.603757736919;5661.801836935688;5716.742746576498;5720.799772007959;5924.822255332347;8846.646134154562;9170.770730731785;9246.260299175916;9307.767305817139;9338.066193380879;8799.868001979847;9134.314926380415;9136.543172841464;9253.074692530694;9294.628214871329;6573.57271777333;6927.376536111774;7200.603966781878;7371.115466143882;7379.852402952019;7690.384769218337;7844.450888437755;7901.960490197742;7925.247101525346;7927.484713493604;7038.542494737826;7044.718211271492;7073.82315442118;7124.501284910214;7314.524555903849;6964.930350696631;6981.057557229912;6987.860242795217;7039.084918960707;7040.5071644984355;6215.751369945332;6283.088952101828;6403.4877209824035;6545.672716364258;6610.3720146586;4884.902301954012;4946.530079642428;4969.055879382906;4969.801207951641;5010.949890501194;4884.142895386503;5006.224035274538;5008.974955125201;5082.161443361804;5101.566366858859 16:25:59 INFO - PROCESS | 16511 | |4;prototype.html;299.36982651518554;304.9893253736119;309.78160396920174;312.06691990947076;312.0809216856359;5451.018816613008;5498.890022199554;5499.367572729132;5515.779368825252;5543.307086614173;5354.170103633943;5372.677639341642;5375.892482150354;5434.972825135868;5441.863953401167;4231.51896836108;4232.5344212136715;4236.7545201043495;4247.193033323674;4252.787360631972;4063.6952228582827;4165.937685890094;4183.811728472226;4191.476065491814;4197.496300443951;4118.958810411902;4129.256733787917;4132.338825787874;4163.666906647476;4168.458100446953;3963.7819919904396;4119.393436559744;4135.31767258402;4152.588120039201;4153.77463648223;3534.770239934396;3636.727245456575;3639.5450568678916;3642.1987162824403;3655.3785856404475;5184.870378240536;5191.454897235773;5201.531862132389;5218.62552538594;5293.788248470057;4498.875281179705;4762.785674644615;4780.880477988043;4781;4788.11419887322;5414.187871819219;5563.638363506359;5596.916046259309;5605.831825045255;5637.408072152406;3995.340768773178;3998.7000974926996;4000.399940009022;4008.3386241270155;4010.1578668479656;5702.629329093637;5874;5897.348742352148;5903.439173278574;5906;4114.547399786021;4138.13099249161;4150.8547200847825;4153.1070819773895;4153.418521407006;4182.309918863414;4185.727927684691;4202.894927626772;4203.306454435045;4212.389203565466;4554.726716397026;4765.356676848651;4805.1590971579835;4822.565969062731;4834.7824347904425;5652.558597557597;5654.434556544395;5668.546516278688;5671;5674.347450043216;1420.4815242436644;1444.1912528983592;1445.927703614815;1447.254663848119;1449.521657852906;868.6525389843987;918.6463211663557;929.7210836748948;938.2634631814129;943.0004195552737;4789.275860690149;4828.227483602606;4857.222844344888;4864.416270047617;4886.633502487328;5052.898942021139;5075.147571136508;5088.6946783193125;5094.745262736848;5105.310783044241;4666.926606880369;4798.760061996886;4828.8792780180775;4839.564439200489;4868;2670.918278097374;2703.526882795503;2720.224735950245;2930.223490774946;2960.097170363017;5901.911471327933;5904.645721256738;5935.970320148372;5952.440450606195;5975.880482390327;5891.941080589139;5904.645721256738;5932.436418540232;5948.672822994777;5967.358976281557;5746.885062298814;5895.882082358329;5924.822255332347;5940.227770389908;5964.761409543569;5741.196232527366;5742.913856292243;5743.798967036134;5746.195532625352;5856.4143585641095;5607.383187849415;5659.320881494247;5720.942790572208;5758.992176369203;5789.8263052108505;5935.34711181761;5955.736820008369;5958.672273024852;5964.880702385841;5984.14491507634;4089.1208390196252;4153.771542565188;4158.189153115113;4158.875233742992;4160.334346504545;5688.886222275449;5789.073748200268;5801.3038435388025;5826.359100499027;5833.708314584339;5585.536967080436;5588.441155884379;5604.719764011865;5609;5618.7190640467;5401.8919621606565;5558.638688485235;5617.8033768817895;5636.577256705846;5653.236813030353;5534.944650553443;5571.9442805571425;5585.134304182858;5589.357223919302;5597.160425935979;5561.5272701820795;5594.86012849682;5668.7732490701555;5678.744456499385;5683.840140746655;5305.559442656421;5529.861753456195;5537.473939975695;5549.780087964847;5550.307156317362 16:25:59 INFO - PROCESS | 16511 | |5;yui.html;634.419506151871;643.314869663808;676.9729210831567;692.9653517324134;727.7198278662713;13807.378667959942;14624.634384140389;15388.461403850868;15472.149031803247;15542.37830486782;13669.65825854354;13886.4445422183;13887.305634718248;13895;13902;799.5202878273034;818.9222023907719;819.8565251081067;820.5815034332503;820.745568873648;663.1611012069711;781.7185813107277;804.7947773317795;810.5622963599678;812.9918700813005;853.4282031039219;855.170484629908;855.5764896376303;855.9186877246651;855.9229669329759;838.7316058861136;839.4291881520563;840.7393707950555;848.8726690996369;849.049065047145;499.5239068552455;596.1177457363127;611.2573223533384;613.1569092497815;615.7321565119188;13525.18848869071;13528.526501572398;13549.661258468617;13551.661208469768;13560.728785424237;13106.148100373444;13752.243626600533;13802.37889294984;13804.723905521934;13869.105630107164;12102.636920892388;12145.453454594475;12154.453049612788;12324.383780811013;12544.184627999151;4310.3534469829465;4338.848140315074;4362.9965108025335;4479.61923236522;4515.525869783658;87268;88640;89095;89792.5510372444;90679;10457.581696732197;10548.630797922036;10563.366198027989;10765.13878889687;10852.565897364175;20273.18907243723;20295.797042029684;20302.492437689176;20318.59362812765;20330.796692033186;7930.722424715107;8025.5585942773705;8305.252527272574;8313.542755148404;8335.708250211213;4245.702800803914;4288.678349123766;4437.33439984005;4456;4457.465104187519;3195.6165260168927;3249.7237734792334;3267;3290.68738469845;3292.654271301527;572.3789688188363;573.9225204597409;589.3782059926733;616.9228846394201;626.0421555020826;623.3517142172091;651.081974416071;681.4412182010802;718.8346680263569;770.942179336552;9669.806603867883;9674.75813104664;9701;9768.724888560098;9771.804563908681;610.6702380714453;627.5607075047485;670.7283550162192;700.6041586503711;730.9451791115688;4413.883888725469;4426.579474949875;4717.834875779331;4803.759812009455;4842.733649649233;125518;125850.37074814568;125897;128421;131302.34348828194;63295;97215.51392242993;101551.49224253831;114345;116050;89941.55029224812;91433.54283228541;91453;93096.53451732697;97868;8697.130286971253;8874.112588741074;8882.555872206492;8904.643814247358;8995.100489950952;55551;56143.43856561382;56516.43483565112;58510.7074464625;60180.39819601923;79416;80012.1992680441;82322.58838706008;82875;84478.57760711157;11221.382823944761;11233.943830280796;11478.655640330804;11680;12164.39178041112;12797;12871.613851584467;13111.934440327737;13413.530526431528;13542.390592423168;11614;11737.178397512092;12187.451564679433;12218.009760153502;12264.693382665504;12111.757764844477;12272.693182670504;12511.499540018298;12649.596437517659;12650.177738446971;11938.224015439317;12077.094217933865;12269.509219631114;12439.315837629018;12850.357482126043;8890.244329232088;8900.510471924106;9320.813583728423;9567.665131720356;9568.378055426376;8602.612882420432;8789.319257626485;8813.2949364052;9750.60997560118;9805.117539421486 16:25:59 INFO - PROCESS | 16511 | __end_tp_report 16:25:59 INFO - PROCESS | 16511 | __start_cc_report 16:25:59 INFO - PROCESS | 16511 | _x_x_mozilla_cycle_collect,1007 16:25:59 INFO - PROCESS | 16511 | __end_cc_report 16:25:59 INFO - PROCESS | 16511 | __startTimestamp1472253959144__endTimestamp 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | ------- Summary: start ------- 16:25:59 INFO - PROCESS | 16511 | Number of tests: 6 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | [#0] dojo.html Cycles:165 Average:5148.91 Median:5326.04 stddev:567.72 (10.7%) stddev-sans-first:542.85 16:25:59 INFO - PROCESS | 16511 | Values: 2959.2 2979.7 2981.7 3009.2 3028.0 4998.7 5044.3 5125.8 5159.5 5204.1 5154.3 5184.0 5235.3 5236.1 5272.1 4686.6 4693.9 4755.3 4764.6 4850.5 4786.3 4806.8 4819.8 4835.2 4852.7 4652.9 4722.5 4738.8 4770.0 4791.4 4724.4 4735.9 4746.5 4750.5 4852.4 4747.4 4764.2 4769.5 4770.6 4785.7 5011.7 5068.9 5161.9 5182.8 5196.7 5497.4 5540.0 5540.2 5566.7 5585.0 5534.6 5552.0 5553.0 5553.2 5574.3 4989.0 5095.0 5180.3 5190.7 5246.1 5671.6 5673.2 5678.0 5686.3 5719.4 5434.4 5434.5 5440.0 5443.1 5459.2 5342.3 5469.5 5480.6 5502.8 5559.3 5439.6 5442.3 5449.7 5458.2 5462.9 5461.1 5462.9 5467.4 5471.6 5547.2 4193.4 4223.1 4232.3 4256.9 4284.2 3813.6 3852.7 3870.0 3896.5 3921.5 5196.3 5207.3 5229.1 5239.2 5243.7 5326.0 5495.3 5527.9 5530.4 5589.9 5241.8 5247.8 5266.1 5316.4 5319.4 4803.8 4815.6 4817.6 4820.6 4871.4 5527.6 5676.3 5700.2 5717.0 5721.9 5552.5 5575.9 5579.4 5632.6 5635.4 5720.0 5744.1 5747.0 5750.6 5761.2 5280.3 5438.5 5465.3 5466.2 5480.9 5518.5 5582.3 5597.5 5653.0 5659.7 5447.8 5457.5 5469.5 5476.0 5479.1 5225.0 5315.2 5410.6 5425.7 5430.4 5336.7 5380.0 5386.4 5434.8 5446.4 5342.4 5384.1 5385.7 5387.5 5418.6 5200.8 5247.1 5322.6 5325.2 5378.7 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | [#1] ext.html Cycles:180 Average:58062.76 Median:390825.50 stddev:111042.10 (28.4%) stddev-sans-first:111269.67 16:25:59 INFO - PROCESS | 16511 | Values: 561.6 588.6 597.5 603.4 603.6 31360.7 32164.5 35032.3 35046.6 43676.6 41078.8 44600.8 45277.3 45403.3 45539.8 8956.4 9078.3 9080.5 9099.3 9099.4 8235.8 8902.7 9007.5 9014.0 10608.3 10794.9 11182.6 11184.9 11186.7 11198.9 10983.3 11044.5 11049.3 11063.4 11064.1 10801.6 10852.5 10874.3 10881.9 10889.3 42897.8 43161.8 43271.1 43291.4 43365.8 3330.7 3346.7 3421.8 3634.4 4099.8 31548.0 32067.4 32982.5 33705.3 34046.5 4165.6 4223.3 4226.4 4243.7 4317.7 336267.0 336371.0 337271.0 337637.0 337940.3 58536.4 58865.7 58970.1 59103.1 59159.7 61818.4 61842.7 61933.7 61974.7 61983.7 17064.2 17276.8 17313.5 17328.7 17329.7 12174.1 12191.3 12207.9 12209.2 12250.3 16542.8 17631.2 17680.0 17688.6 17692.2 6602.8 6638.6 6683.8 6787.7 6797.2 969.8 985.2 995.8 1032.5 1053.5 31436.4 31447.7 31490.9 31576.8 31979.7 946.8 1074.8 1079.4 1142.4 1150.5 15375.9 16313.9 16325.6 16440.4 16695.7 507207.0 511371.0 511624.0 512675.0 518499.0 58098.0 58187.4 58340.4 58351.4 58540.7 1213.2 1300.9 1330.8 1355.9 1364.3 30851.5 33035.7 33106.7 33346.0 33599.5 51052.2 51369.4 51419.7 51617.2 51679.7 389048.0 390199.0 391452.0 392667.0 392750.0 27749.9 28975.5 28983.1 30075.7 41870.8 47589.3 47709.0 47777.5 48051.4 49779.3 40409.0 40644.2 40655.4 40886.8 41537.0 39911.0 41025.2 41053.2 41165.8 42699.8 39808.0 40671.6 40734.2 40805.6 41574.6 33668.0 35783.8 36276.1 36693.8 36730.6 27362.5 27626.6 27695.7 27815.6 27951.6 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | [#2] jquery.html Cycles:180 Average:28015.70 Median:20726.00 stddev:79099.55 (381.6%) stddev-sans-first:79294.21 16:25:59 INFO - PROCESS | 16511 | Values: 372.8 394.7 408.1 410.4 426.7 13798.8 18421.4 19016.7 19583.6 19607.2 12013.6 12475.9 12516.5 12585.4 12588.2 3979.0 5280.5 5410.4 5414.1 5415.8 5654.3 5878.5 5934.9 6027.8 6035.4 5837.4 5985.7 5990.6 5999.0 6022.2 5976.3 5993.9 5995.3 6008.0 6015.9 5189.3 5466.3 5494.3 5562.1 5793.7 13933.2 14018.6 14180.9 14318.6 14401.2 2209.2 2230.7 2280.4 2362.1 2540.2 9280.9 9743.4 9834.8 9867.0 9869.4 1779.2 1796.9 1804.3 1822.8 1834.4 75222.0 83181.0 83949.6 84316.6 84861.2 10887.9 10965.8 11286.0 11373.1 11435.1 15147.9 15195.7 15196.2 15197.0 15210.9 8040.2 8109.8 8131.8 8191.2 8417.0 7671.9 7783.5 7903.2 7975.4 8206.2 4636.2 4678.3 4687.6 4694.1 4923.5 1919.7 2004.3 2011.2 2037.2 2039.3 838.9 945.9 972.9 1030.6 1041.3 18948.7 19658.3 19673.9 19762.3 19783.0 916.4 927.7 939.0 951.5 961.2 10193.0 10778.4 10860.5 10950.8 10979.8 476940.0 477781.4 479706.0 480847.0 482948.0 85404.0 86303.0 86403.0 86761.6 89423.0 947.5 967.1 988.5 988.5 991.8 16697.2 17056.0 17495.7 17501.0 17798.2 39844.0 40182.6 40291.0 40632.0 41041.6 54246.0 55017.4 55181.2 56236.0 57354.0 8066.3 8259.1 8328.0 8406.0 8638.1 10762.4 12074.9 13613.5 13659.9 13669.7 11548.7 11707.0 11728.8 11761.6 11788.5 10875.2 11561.9 11780.5 11911.9 11924.6 11403.2 11629.0 11990.3 12184.0 12251.5 8669.9 8733.2 8785.5 8849.4 8970.1 10823.0 11294.7 11760.9 11854.1 11895.9 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | [#3] mootools.html Cycles:180 Average:5303.79 Median:4988.01 stddev:2932.09 (58.8%) stddev-sans-first:2924.77 16:25:59 INFO - PROCESS | 16511 | Values: 1286.5 1427.5 1456.3 1577.3 1765.6 7565.6 7878.8 7923.5 8113.5 8134.6 7963.4 8063.7 8076.4 8076.5 8078.3 2243.6 2258.3 2259.9 2260.4 2269.8 2229.6 2263.8 2297.9 2303.1 2310.8 2260.8 2288.7 2296.9 2305.2 2305.9 2188.2 2199.3 2210.9 2210.9 2214.1 2198.6 2199.3 2203.7 2204.7 2209.6 7887.9 7937.0 7958.0 7985.5 8032.5 4703.8 4816.1 4825.8 4832.3 4837.2 3095.0 3194.1 3244.7 3248.2 3256.4 1095.9 1103.1 1112.3 1126.1 1147.9 10709.8 10777.2 10856.5 10862.1 10896.8 3994.4 4106.2 4112.3 4199.8 4230.0 8617.5 8619.3 8630.1 8652.3 8653.4 4805.4 4807.7 4826.9 4830.6 4831.8 3990.3 4323.4 4469.1 4548.5 4549.1 3574.2 3588.1 3666.2 3714.6 3720.3 1114.4 1163.2 1165.2 1170.6 1175.0 916.7 923.9 928.8 945.4 983.4 5423.1 5475.1 5583.6 5621.2 5760.1 413.6 415.8 416.8 420.9 425.7 3807.2 3877.0 3893.6 3926.6 4014.2 9192.8 9922.5 9976.2 9985.8 10023.4 9904.6 9930.5 9931.3 9953.2 9955.7 7190.2 7389.1 7443.5 7623.6 7628.0 5660.6 5661.8 5716.7 5720.8 5924.8 8846.6 9170.8 9246.3 9307.8 9338.1 8799.9 9134.3 9136.5 9253.1 9294.6 6573.6 6927.4 7200.6 7371.1 7379.9 7690.4 7844.5 7902.0 7925.2 7927.5 7038.5 7044.7 7073.8 7124.5 7314.5 6964.9 6981.1 6987.9 7039.1 7040.5 6215.8 6283.1 6403.5 6545.7 6610.4 4884.9 4946.5 4969.1 4969.8 5010.9 4884.1 5006.2 5009.0 5082.2 5101.6 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | [#4] prototype.html Cycles:180 Average:4680.31 Median:5329.86 stddev:1392.66 (26.1%) stddev-sans-first:1357.19 16:25:59 INFO - PROCESS | 16511 | Values: 299.4 305.0 309.8 312.1 312.1 5451.0 5498.9 5499.4 5515.8 5543.3 5354.2 5372.7 5375.9 5435.0 5441.9 4231.5 4232.5 4236.8 4247.2 4252.8 4063.7 4165.9 4183.8 4191.5 4197.5 4119.0 4129.3 4132.3 4163.7 4168.5 3963.8 4119.4 4135.3 4152.6 4153.8 3534.8 3636.7 3639.5 3642.2 3655.4 5184.9 5191.5 5201.5 5218.6 5293.8 4498.9 4762.8 4780.9 4781.0 4788.1 5414.2 5563.6 5596.9 5605.8 5637.4 3995.3 3998.7 4000.4 4008.3 4010.2 5702.6 5874.0 5897.3 5903.4 5906.0 4114.5 4138.1 4150.9 4153.1 4153.4 4182.3 4185.7 4202.9 4203.3 4212.4 4554.7 4765.4 4805.2 4822.6 4834.8 5652.6 5654.4 5668.5 5671.0 5674.3 1420.5 1444.2 1445.9 1447.3 1449.5 868.7 918.6 929.7 938.3 943.0 4789.3 4828.2 4857.2 4864.4 4886.6 5052.9 5075.1 5088.7 5094.7 5105.3 4666.9 4798.8 4828.9 4839.6 4868.0 2670.9 2703.5 2720.2 2930.2 2960.1 5901.9 5904.6 5936.0 5952.4 5975.9 5891.9 5904.6 5932.4 5948.7 5967.4 5746.9 5895.9 5924.8 5940.2 5964.8 5741.2 5742.9 5743.8 5746.2 5856.4 5607.4 5659.3 5720.9 5759.0 5789.8 5935.3 5955.7 5958.7 5964.9 5984.1 4089.1 4153.8 4158.2 4158.9 4160.3 5688.9 5789.1 5801.3 5826.4 5833.7 5585.5 5588.4 5604.7 5609.0 5618.7 5401.9 5558.6 5617.8 5636.6 5653.2 5534.9 5571.9 5585.1 5589.4 5597.2 5561.5 5594.9 5668.8 5678.7 5683.8 5305.6 5529.9 5537.5 5549.8 5550.3 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - PROCESS | 16511 | [#5] yui.html Cycles:180 Average:21555.02 Median:56329.94 stddev:32929.79 (58.5%) stddev-sans-first:32984.70 16:25:59 INFO - PROCESS | 16511 | Values: 634.4 643.3 677.0 693.0 727.7 13807.4 14624.6 15388.5 15472.1 15542.4 13669.7 13886.4 13887.3 13895.0 13902.0 799.5 818.9 819.9 820.6 820.7 663.2 781.7 804.8 810.6 813.0 853.4 855.2 855.6 855.9 855.9 838.7 839.4 840.7 848.9 849.0 499.5 596.1 611.3 613.2 615.7 13525.2 13528.5 13549.7 13551.7 13560.7 13106.1 13752.2 13802.4 13804.7 13869.1 12102.6 12145.5 12154.5 12324.4 12544.2 4310.4 4338.8 4363.0 4479.6 4515.5 87268.0 88640.0 89095.0 89792.6 90679.0 10457.6 10548.6 10563.4 10765.1 10852.6 20273.2 20295.8 20302.5 20318.6 20330.8 7930.7 8025.6 8305.3 8313.5 8335.7 4245.7 4288.7 4437.3 4456.0 4457.5 3195.6 3249.7 3267.0 3290.7 3292.7 572.4 573.9 589.4 616.9 626.0 623.4 651.1 681.4 718.8 770.9 9669.8 9674.8 9701.0 9768.7 9771.8 610.7 627.6 670.7 700.6 730.9 4413.9 4426.6 4717.8 4803.8 4842.7 125518.0 125850.4 125897.0 128421.0 131302.3 63295.0 97215.5 101551.5 114345.0 116050.0 89941.6 91433.5 91453.0 93096.5 97868.0 8697.1 8874.1 8882.6 8904.6 8995.1 55551.0 56143.4 56516.4 58510.7 60180.4 79416.0 80012.2 82322.6 82875.0 84478.6 11221.4 11233.9 11478.7 11680.0 12164.4 12797.0 12871.6 13111.9 13413.5 13542.4 11614.0 11737.2 12187.5 12218.0 12264.7 12111.8 12272.7 12511.5 12649.6 12650.2 11938.2 12077.1 12269.5 12439.3 12850.4 8890.2 8900.5 9320.8 9567.7 9568.4 8602.6 8789.3 8813.3 9750.6 9805.1 16:25:59 INFO - PROCESS | 16511 | -------- Summary: end -------- 16:25:59 INFO - PROCESS | 16511 | 16:25:59 INFO - TEST-INFO | 16511: exit 0 16:26:00 INFO - TEST-OK | dromaeo_css | took 1117017ms 16:26:00 INFO - TEST-START | kraken 16:26:00 INFO - operating with platform_type : linux_ 16:26:00 INFO - Initialising browser for kraken test... 16:26:00 INFO - TEST-INFO | started process 16817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHRpabv/profile http://localhost:53526/getInfo.html) 16:26:04 INFO - PROCESS | 16817 | __metrics Screen width/height:1600/1200 16:26:04 INFO - PROCESS | 16817 | colorDepth:24 16:26:04 INFO - PROCESS | 16817 | Browser inner width/height: 1024/697 16:26:04 INFO - PROCESS | 16817 | __metrics 16:26:05 INFO - PROCESS | 16817 | 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" 16:26:05 INFO - PROCESS | 16817 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:26:06 INFO - PROCESS | 16817 | console.error: PushService: 16:26:06 INFO - PROCESS | 16817 | stateChangeProcessEnqueue: Error transitioning state 16:26:06 INFO - PROCESS | 16817 | UnknownError 16:26:06 INFO - TEST-INFO | 16817: exit 0 16:26:06 INFO - Browser initialized. 16:26:06 INFO - Running cycle 1/1 for kraken test... 16:26:06 INFO - TEST-INFO | started process 16899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHRpabv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:18 INFO - PROCESS | 16899 | RSS: Main: 183152640 16:26:18 INFO - PROCESS | 16899 | 16:26:21 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:22 INFO - PROCESS | 16899 | RSS: Main: 241045504 16:26:22 INFO - PROCESS | 16899 | 16:26:24 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-dft) 16:26:25 INFO - PROCESS | 16899 | RSS: Main: 227000320 16:26:25 INFO - PROCESS | 16899 | 16:26:28 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-fft) 16:26:29 INFO - PROCESS | 16899 | RSS: Main: 305057792 16:26:29 INFO - PROCESS | 16899 | 16:26:31 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-oscillator) 16:26:31 INFO - PROCESS | 16899 | RSS: Main: 215650304 16:26:31 INFO - PROCESS | 16899 | 16:26:33 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:26:34 INFO - PROCESS | 16899 | RSS: Main: 217608192 16:26:34 INFO - PROCESS | 16899 | 16:26:37 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53526/tests/kraken/driver.html?testName=imaging-darkroom) 16:26:38 INFO - PROCESS | 16899 | RSS: Main: 256348160 16:26:38 INFO - PROCESS | 16899 | 16:26:41 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53526/tests/kraken/driver.html?testName=imaging-desaturate) 16:26:42 INFO - PROCESS | 16899 | RSS: Main: 255205376 16:26:42 INFO - PROCESS | 16899 | 16:26:44 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53526/tests/kraken/driver.html?testName=json-parse-financial) 16:26:45 INFO - PROCESS | 16899 | RSS: Main: 255926272 16:26:45 INFO - PROCESS | 16899 | 16:26:47 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:26:47 INFO - PROCESS | 16899 | RSS: Main: 217858048 16:26:47 INFO - PROCESS | 16899 | 16:26:49 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:26:50 INFO - PROCESS | 16899 | RSS: Main: 224485376 16:26:50 INFO - PROCESS | 16899 | 16:26:52 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:26:52 INFO - PROCESS | 16899 | RSS: Main: 222822400 16:26:52 INFO - PROCESS | 16899 | 16:26:55 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:26:55 INFO - PROCESS | 16899 | RSS: Main: 223084544 16:26:55 INFO - PROCESS | 16899 | 16:26:58 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:26:59 INFO - PROCESS | 16899 | RSS: Main: 221581312 16:26:59 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53526/tests/kraken/driver.html?testName=ai-astar) 16:27:01 INFO - PROCESS | 16899 | RSS: Main: 272306176 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | __start_tp_report 16:27:01 INFO - PROCESS | 16899 | _x_x_mozilla_page_load 16:27:01 INFO - PROCESS | 16899 | _x_x_mozilla_page_load_details 16:27:01 INFO - PROCESS | 16899 | |i|pagename|runs| 16:27:01 INFO - PROCESS | 16899 | |0;ai-astar;112;112;128;111;113;112;114;111;110;111 16:27:01 INFO - PROCESS | 16899 | |1;audio-beat-detection;150;122;144;177;121;155;142;120;174;120 16:27:01 INFO - PROCESS | 16899 | |2;audio-dft;162;161;161;161;161;162;160;162;161;161 16:27:01 INFO - PROCESS | 16899 | |3;audio-fft;74;74;75;175;77;75;75;74;161;77 16:27:01 INFO - PROCESS | 16899 | |4;audio-oscillator;82;82;140;82;82;83;149;81;82;140 16:27:01 INFO - PROCESS | 16899 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;117;117 16:27:01 INFO - PROCESS | 16899 | |6;imaging-darkroom;146;147;146;146;146;146;145;145;145;147 16:27:01 INFO - PROCESS | 16899 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;95 16:27:01 INFO - PROCESS | 16899 | |8;json-parse-financial;55;52;55;53;54;54;57;54;54;53 16:27:01 INFO - PROCESS | 16899 | |9;json-stringify-tinderbox;62;62;61;61;62;62;63;62;63;63 16:27:01 INFO - PROCESS | 16899 | |10;stanford-crypto-aes;86;82;79;83;83;79;79;79;79;79 16:27:01 INFO - PROCESS | 16899 | |11;stanford-crypto-ccm;126;134;121;122;126;122;130;130;166;125 16:27:01 INFO - PROCESS | 16899 | |12;stanford-crypto-pbkdf2;165;166;161;166;167;164;165;166;164;163 16:27:01 INFO - PROCESS | 16899 | |13;stanford-crypto-sha256-iterative;66;69;67;66;65;66;64;64;64;64 16:27:01 INFO - PROCESS | 16899 | __end_tp_report 16:27:01 INFO - PROCESS | 16899 | __start_cc_report 16:27:01 INFO - PROCESS | 16899 | _x_x_mozilla_cycle_collect,1720 16:27:01 INFO - PROCESS | 16899 | __end_cc_report 16:27:01 INFO - PROCESS | 16899 | __startTimestamp1472254021253__endTimestamp 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | ------- Summary: start ------- 16:27:01 INFO - PROCESS | 16899 | Number of tests: 14 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#0] ai-astar Cycles:10 Average:113.40 Median:112.00 stddev:5.25 (4.7%) stddev-sans-first:5.55 16:27:01 INFO - PROCESS | 16899 | Values: 112.0 112.0 128.0 111.0 113.0 112.0 114.0 111.0 110.0 111.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.00 stddev:21.84 (14.9%) stddev-sans-first:22.99 16:27:01 INFO - PROCESS | 16899 | Values: 150.0 122.0 144.0 177.0 121.0 155.0 142.0 120.0 174.0 120.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:27:01 INFO - PROCESS | 16899 | Values: 162.0 161.0 161.0 161.0 161.0 162.0 160.0 162.0 161.0 161.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.31 (52.4%) stddev-sans-first:41.05 16:27:01 INFO - PROCESS | 16899 | Values: 74.0 74.0 75.0 175.0 77.0 75.0 75.0 74.0 161.0 77.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:82.00 stddev:29.57 (36.1%) stddev-sans-first:30.61 16:27:01 INFO - PROCESS | 16899 | Values: 82.0 82.0 140.0 82.0 82.0 83.0 149.0 81.0 82.0 140.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:27:01 INFO - PROCESS | 16899 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 16:27:01 INFO - PROCESS | 16899 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 147.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:27:01 INFO - PROCESS | 16899 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.37 (2.5%) stddev-sans-first:1.41 16:27:01 INFO - PROCESS | 16899 | Values: 55.0 52.0 55.0 53.0 54.0 54.0 57.0 54.0 54.0 53.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 16:27:01 INFO - PROCESS | 16899 | Values: 62.0 62.0 61.0 61.0 62.0 62.0 63.0 62.0 63.0 63.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.53 (3.1%) stddev-sans-first:1.86 16:27:01 INFO - PROCESS | 16899 | Values: 86.0 82.0 79.0 83.0 83.0 79.0 79.0 79.0 79.0 79.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:128.00 stddev:13.24 (10.3%) stddev-sans-first:13.96 16:27:01 INFO - PROCESS | 16899 | Values: 126.0 134.0 121.0 122.0 126.0 122.0 130.0 130.0 166.0 125.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:1.77 (1.1%) stddev-sans-first:1.87 16:27:01 INFO - PROCESS | 16899 | Values: 165.0 166.0 161.0 166.0 167.0 164.0 165.0 166.0 164.0 163.0 16:27:01 INFO - PROCESS | 16899 | 16:27:01 INFO - PROCESS | 16899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.74 16:27:01 INFO - PROCESS | 16899 | Values: 66.0 69.0 67.0 66.0 65.0 66.0 64.0 64.0 64.0 64.0 16:27:01 INFO - PROCESS | 16899 | -------- Summary: end -------- 16:27:01 INFO - PROCESS | 16899 | 16:27:02 INFO - TEST-INFO | 16899: exit 0 16:27:02 INFO - TEST-OK | kraken | took 62406ms 16:27:02 INFO - SUITE-END | took 1179s 16:27:02 INFO - Completed test suite (00:19:39) 16:27:02 INFO - javascript benchmark 16:27:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2959.2158078109296, 2979.746721528669, 2981.746551543119, 3009.2176034231093, 3028.0, 4998.700077995323, 5044.293798868152, 5125.8462246132585, 5159.509846564575, 5204.063268611653, 5154.278401023859, 5184.040952423804, 5235.267062611238, 5236.083685355066, 5272.051030814452, 4686.578207961283, 4693.929591056137, 4755.262934245197, 4764.571188593026, 4850.490698476645, 4786.2581299898575, 4806.807727690888, 4819.807207711705, 4835.15384807659, 4852.708837469745, 4652.930206046895, 4722.504137065627, 4738.763061846928, 4769.976150119227, 4791.353167322419, 4724.385829842133, 4735.881602959919, 4746.501617330199, 4750.50119737426, 4852.393450818648, 4747.430308363018, 4764.166270902613, 4769.4515130760055, 4770.594499467515, 4785.66500344976, 5011.674241174312, 5068.923966140511, 5161.870953226162, 5182.818601348935, 5196.740162991835, 5497.422770609109, 5539.975104605661, 5540.196671482653, 5566.666000040011, 5584.972075139598, 5534.557235421197, 5552.0, 5552.972235138798, 5553.194786755938, 5574.275344205268, 4988.950110498885, 5095.0, 5180.274761533426, 5190.662606930538, 5246.134387826042, 5671.602987790898, 5673.234113394721, 5678.0, 5686.289213848269, 5719.399463056402, 5434.375046869582, 5434.483724046209, 5439.972800135974, 5443.101888188405, 5459.153831156098, 5342.332208473941, 5469.535089517435, 5480.6437581557075, 5502.752376143083, 5559.33288005442, 5439.592030597721, 5442.292501974797, 5449.6730196188355, 5458.235846981426, 5462.918056229159, 5461.1262198048125, 5462.890742185134, 5467.371252305956, 5471.632091977006, 5547.1679248113105, 4193.370994350872, 4223.113146239262, 4232.3016702243785, 4256.87229383119, 4284.207421627009, 3813.618638136164, 3852.6917846572205, 3869.9613003870163, 3896.5324161100284, 3921.490206273166, 5196.32447781786, 5207.3490813648295, 5229.058769421541, 5239.161734122522, 5243.737813109329, 5326.041312563698, 5495.285612870382, 5527.861803454865, 5530.419305972815, 5589.860253493695, 5241.790328386822, 5247.763850626731, 5266.131088370376, 5316.415194328621, 5319.361676598833, 4803.759812009385, 4815.614750819926, 4817.614590832725, 4820.638452116105, 4871.415430148334, 5527.640703354349, 5676.290463692038, 5700.230468886647, 5716.971415142898, 5721.8569535761935, 5552.5280351168985, 5575.860603484945, 5579.386267510652, 5632.633878797865, 5635.408282130317, 5720.027595308724, 5744.0522313817755, 5746.9712651436475, 5750.6262092963825, 5761.164631128379, 5280.339957505312, 5438.537724293479, 5465.344158700981, 5466.180072989084, 5480.890382192254, 5518.530924871431, 5582.27430434041, 5597.468240517144, 5653.038983372919, 5659.688717120598, 5447.836564903059, 5457.508824205841, 5469.507744303032, 5476.04169270384, 5479.123340265538, 5225.0, 5315.176147697113, 5410.648307860134, 5425.701586412627, 5430.375506816608, 5336.653117547347, 5380.031594313061, 5386.35363756336, 5434.755436005468, 5446.400895901527, 5342.43904390049, 5384.057789886676, 5385.676859388449, 5387.515123638735, 5418.593605479526, 5200.817971370984, 5247.055530004636, 5322.600804939722, 5325.2278419628165, 5378.6503877249415], "value": 5111.46598832029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.5735739242996, 588.6026931821021, 597.4772074434869, 603.3845477612837, 603.5503549855358, 31360.68639313606, 32164.517532237005, 35032.2993540129, 35046.649533504686, 43676.56323436765, 41078.794606027004, 44600.776996114975, 45277.32084018734, 45403.31895021578, 45539.77230113853, 8956.373053886247, 9078.273738100968, 9080.500572468512, 9099.272058235358, 9099.408538444979, 8235.794105147359, 8902.73291801247, 9007.54962251888, 9014.0, 10608.257421980465, 10794.946025269863, 11182.552697892075, 11184.888151118506, 11186.720331991724, 11198.888011119907, 10983.286086404398, 11044.502997365138, 11049.33703977764, 11063.446827658585, 11064.114870810316, 10801.5679372825, 10852.511636976355, 10874.347539147677, 10881.945590272077, 10889.292196007234, 42897.785511072245, 43161.78419107884, 43271.10560049579, 43291.35062974058, 43365.78317108426, 3330.7002369786837, 3346.6987971082476, 3421.7775844570274, 3634.3650506781, 4099.836006559734, 31548.0, 32067.358652827046, 32982.50526242084, 33705.32589348224, 34046.48930266048, 4165.58344165584, 4223.260929337353, 4226.429432026668, 4243.745375277463, 4317.740935543846, 336267.0, 336371.0, 337271.0, 337637.0, 337940.3102984494, 58536.4146358531, 58865.70567147137, 58970.11544826831, 59103.11345329823, 59159.704201478715, 61818.38181618216, 61842.690786545776, 61933.69033154805, 61974.69012654908, 61983.690081549306, 17064.2321095551, 17276.827231727773, 17313.53729254129, 17328.740068898976, 17329.7400538992, 12174.14780965324, 12191.329476878856, 12207.877921220852, 12209.206401583868, 12250.326232057323, 16542.751858722128, 17631.206595703225, 17680.0, 17688.55778605545, 17692.203850826743, 6602.801915942529, 6638.618511782297, 6683.7660681875905, 6787.694553745093, 6797.150356205474, 969.7672558585889, 985.1921424431897, 995.8058178655237, 1032.4785983078648, 1053.4679986606714, 31436.371272574877, 31447.685523144934, 31490.89781857624, 31576.842115789274, 31979.68020319767, 946.7633091727068, 1074.785042991405, 1079.3739631013993, 1142.4287856071965, 1150.4707834396272, 15375.875214910468, 16313.91843040801, 16325.591860203353, 16440.424585139463, 16695.74956375655, 507207.0, 511371.0, 511624.0, 512675.0, 518499.0, 58098.0, 58187.4181258182, 58340.416595834344, 58351.41648583545, 58540.707296463246, 1213.1811027556541, 1300.8959283257316, 1330.846952600444, 1355.8711922367359, 1364.2769332253922, 30851.537226942062, 33035.669643303256, 33106.668933311325, 33346.0, 33599.49600755942, 51052.23421648752, 51369.43152842268, 51419.74290128675, 51617.22574161466, 51679.74160129175, 389048.0, 390199.0, 391452.0, 392667.0, 392750.0, 27749.861250694426, 28975.522937247664, 28983.13050608485, 30075.699243008166, 41870.790646046575, 47589.28616070693, 47709.0, 47777.522224777305, 48051.35717535569, 49779.25331119964, 40409.0, 40644.187116256915, 40655.39016914689, 40886.79556602198, 41537.0, 39911.006674498945, 41025.1794964105, 41053.178936421704, 41165.79417102895, 42699.7865010673, 39808.0, 40671.59328406678, 40734.18531629292, 40805.59194408018, 41574.58425415828, 33668.0, 35783.82108089443, 36276.09309767277, 36693.816530917175, 36730.5923289207, 27362.45275094447, 27626.5856012164, 27695.72304277012, 27815.582766258118, 27951.58072628953], "value": 20208.012538745068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.7707459912155, 394.733554850476, 408.0879234909976, 410.4110601287153, 426.7439536278234, 13798.793018104723, 18421.35525256616, 19016.714749278737, 19583.608327833434, 19607.21571137153, 12013.639590812269, 12475.875241247584, 12516.49934002641, 12585.433655485502, 12588.18176818506, 3978.9801050994706, 5280.5247527722495, 5410.377806552257, 5414.052540805363, 5415.783368665248, 5654.264945557072, 5878.50032747217, 5934.851628709273, 6027.789027384042, 6035.366286539916, 5837.445442682938, 5985.730642121115, 5990.640561566298, 5998.9700051499685, 6022.217111775463, 5976.342602313742, 5993.940060599425, 5995.250593675791, 6008.03871380577, 6015.909761353583, 5189.299444574972, 5466.316710411199, 5494.313210848644, 5562.137868630369, 5793.681347525884, 13933.164010159322, 14018.579442616738, 14180.858191418058, 14318.57044288673, 14401.20793356365, 2209.2488553891594, 2230.654248591471, 2280.3728974532137, 2362.1378196957985, 2540.2125341144306, 9280.932692740354, 9743.366681165702, 9834.75413114678, 9867.0, 9869.407835529892, 1779.1904683369037, 1796.8742188046842, 1804.3414153833755, 1822.7539282197, 1834.4404956488265, 75222.0, 83181.0, 83949.58025209834, 84316.57841710813, 84861.15138848595, 10887.891121088845, 10965.780684386427, 11286.0, 11373.147013973985, 11435.14236432271, 15147.924260378628, 15195.696086078438, 15196.240187990556, 15197.0, 15210.923945380202, 8040.195980401913, 8109.797255068553, 8131.79670508242, 8191.221833925768, 8417.0, 7671.923280767232, 7783.494072885244, 7903.170167132484, 7975.401844861659, 8206.179382061866, 4636.165490211794, 4678.345031695565, 4687.648426367968, 4694.108119457293, 4923.507649235048, 1919.6640587897061, 2004.3385682724665, 2011.2256781139367, 2037.1647624473894, 2039.34740882919, 838.8951381077366, 945.9101385368378, 972.863799068131, 1030.567161792049, 1041.2763129624989, 18948.715769263472, 19658.311959081362, 19673.901630491757, 19762.320202782637, 19783.01084945747, 916.3951791817368, 927.6660402255183, 938.9718258506924, 951.538503825644, 961.245422343457, 10193.0, 10778.353298802096, 10860.511276992554, 10950.780984380268, 10979.780404391868, 476940.0, 477781.44437111757, 479706.0, 480847.0, 482948.0, 85404.0, 86303.0, 86403.0, 86761.56619216989, 89423.0, 947.4560804240635, 967.086103632075, 988.4563490080427, 988.5106872098357, 991.8115558044093, 16697.2486238122, 17056.0, 17495.737563936807, 17501.0, 17798.199081041126, 39844.0, 40182.59817401788, 40291.0, 40632.0, 41041.58958410378, 54246.0, 55017.44982550123, 55181.181191123454, 56236.0, 57354.0, 8066.314363279187, 8259.050209225776, 8327.958360208402, 8406.0, 8638.136186381564, 10762.3542587445, 12074.879251207376, 13613.455461781417, 13659.863401366256, 13669.726605467637, 11548.653540393801, 11707.0, 11728.824067638821, 11761.647150585497, 11788.469518871843, 10875.184361173102, 11561.942190288995, 11780.52877884875, 11911.880881191077, 11924.642260732191, 11403.201775875608, 11629.0, 11990.280583165038, 12184.0, 12251.509939602316, 8669.869951950852, 8733.214010739064, 8785.516796575994, 8849.380543361904, 8970.147835955573, 10823.0, 11294.717632059264, 11760.882391176321, 11854.110941679237, 11895.881041189477], "value": 8883.342751849077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.4854058376654, 1427.5360507834953, 1456.3228098933996, 1577.329634905165, 1765.638044200938, 7565.6217189140525, 7878.763637090882, 7923.524588524685, 8113.472624279418, 8134.6339414726335, 7963.362930965523, 8063.717769878055, 8076.3942704297115, 8076.5154090754595, 8078.272955434009, 2243.562505311469, 2258.3112150794, 2259.8644081355087, 2260.4122928038746, 2269.7503274639776, 2229.6209644360497, 2263.8302127340435, 2297.931062068141, 2303.1017903017837, 2310.7573704760925, 2260.8078313343303, 2288.7367952685404, 2296.850704704197, 2305.204704376987, 2305.9192928247517, 2188.2013065231154, 2199.2522542335523, 2210.8784016879067, 2210.9166508410844, 2214.136486770161, 2198.6372248578964, 2199.3401979406276, 2203.724534433196, 2204.7023651806962, 2209.591225623265, 7887.881681774778, 7936.960315198445, 7958.0, 7985.480943738638, 8032.518048917083, 4703.764811759433, 4816.133096042711, 4825.782839772183, 4832.251001094836, 4837.1776797944085, 3094.9941269087412, 3194.1216165554424, 3244.7241984431116, 3248.187953011747, 3256.3812875553567, 1095.9232853700244, 1103.0623969625753, 1112.2659045030323, 1126.1272513801869, 1147.9311241325463, 10709.785804283949, 10777.245592808507, 10856.511456984455, 10862.076723478593, 10896.782064358747, 3994.420808982681, 4106.1582375613525, 4112.259793237246, 4199.811008504625, 4229.97885010573, 8617.48295102296, 8619.310455163697, 8630.050694423608, 8652.307815374756, 8653.350998675125, 4805.399325084364, 4807.687500312469, 4826.927596086061, 4830.637702172351, 4831.806727730851, 3990.341593637075, 4323.3947247385395, 4469.061497085583, 4548.499665036843, 4549.067441174551, 3574.249407624376, 3588.085038315265, 3666.2300916807767, 3714.5542534895985, 3720.2745464634136, 1114.3815182573749, 1163.168334640736, 1165.155262434728, 1170.590293397304, 1174.9706257343635, 916.6745805239177, 923.8845144356956, 928.7631653928205, 945.4091193004373, 983.3608154699359, 5423.105187643994, 5475.09660905954, 5583.637063590853, 5621.18492818539, 5760.135979603093, 413.6256687697638, 415.7983378061638, 416.8207670701567, 420.8905684521985, 425.6849931051062, 3807.162424266657, 3876.96123038766, 3893.6301051400637, 3926.6073392660505, 4014.237294913957, 9192.81614367709, 9922.454265015349, 9976.152027077635, 9985.750356241153, 10023.448710321003, 9904.55429505674, 9930.453825039693, 9931.255155863339, 9953.203743700487, 9955.651552195639, 7190.209077001526, 7389.076365454318, 7443.516171448839, 7623.580703061274, 7627.961860190663, 5660.603757736919, 5661.801836935688, 5716.742746576498, 5720.799772007959, 5924.822255332347, 8846.646134154562, 9170.770730731785, 9246.260299175916, 9307.767305817139, 9338.066193380879, 8799.868001979847, 9134.314926380415, 9136.543172841464, 9253.074692530694, 9294.628214871329, 6573.57271777333, 6927.376536111774, 7200.603966781878, 7371.115466143882, 7379.852402952019, 7690.384769218337, 7844.450888437755, 7901.960490197742, 7925.247101525346, 7927.484713493604, 7038.542494737826, 7044.718211271492, 7073.82315442118, 7124.501284910214, 7314.524555903849, 6964.930350696631, 6981.057557229912, 6987.860242795217, 7039.084918960707, 7040.5071644984355, 6215.751369945332, 6283.088952101828, 6403.4877209824035, 6545.672716364258, 6610.3720146586, 4884.902301954012, 4946.530079642428, 4969.055879382906, 4969.801207951641, 5010.949890501194, 4884.142895386503, 5006.224035274538, 5008.974955125201, 5082.161443361804, 5101.566366858859], "value": 4226.990576079429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.36982651518554, 304.9893253736119, 309.78160396920174, 312.06691990947076, 312.0809216856359, 5451.018816613008, 5498.890022199554, 5499.367572729132, 5515.779368825252, 5543.307086614173, 5354.170103633943, 5372.677639341642, 5375.892482150354, 5434.972825135868, 5441.863953401167, 4231.51896836108, 4232.5344212136715, 4236.7545201043495, 4247.193033323674, 4252.787360631972, 4063.6952228582827, 4165.937685890094, 4183.811728472226, 4191.476065491814, 4197.496300443951, 4118.958810411902, 4129.256733787917, 4132.338825787874, 4163.666906647476, 4168.458100446953, 3963.7819919904396, 4119.393436559744, 4135.31767258402, 4152.588120039201, 4153.77463648223, 3534.770239934396, 3636.727245456575, 3639.5450568678916, 3642.1987162824403, 3655.3785856404475, 5184.870378240536, 5191.454897235773, 5201.531862132389, 5218.62552538594, 5293.788248470057, 4498.875281179705, 4762.785674644615, 4780.880477988043, 4781.0, 4788.11419887322, 5414.187871819219, 5563.638363506359, 5596.916046259309, 5605.831825045255, 5637.408072152406, 3995.340768773178, 3998.7000974926996, 4000.399940009022, 4008.3386241270155, 4010.1578668479656, 5702.629329093637, 5874.0, 5897.348742352148, 5903.439173278574, 5906.0, 4114.547399786021, 4138.13099249161, 4150.8547200847825, 4153.1070819773895, 4153.418521407006, 4182.309918863414, 4185.727927684691, 4202.894927626772, 4203.306454435045, 4212.389203565466, 4554.726716397026, 4765.356676848651, 4805.1590971579835, 4822.565969062731, 4834.7824347904425, 5652.558597557597, 5654.434556544395, 5668.546516278688, 5671.0, 5674.347450043216, 1420.4815242436644, 1444.1912528983592, 1445.927703614815, 1447.254663848119, 1449.521657852906, 868.6525389843987, 918.6463211663557, 929.7210836748948, 938.2634631814129, 943.0004195552737, 4789.275860690149, 4828.227483602606, 4857.222844344888, 4864.416270047617, 4886.633502487328, 5052.898942021139, 5075.147571136508, 5088.6946783193125, 5094.745262736848, 5105.310783044241, 4666.926606880369, 4798.760061996886, 4828.8792780180775, 4839.564439200489, 4868.0, 2670.918278097374, 2703.526882795503, 2720.224735950245, 2930.223490774946, 2960.097170363017, 5901.911471327933, 5904.645721256738, 5935.970320148372, 5952.440450606195, 5975.880482390327, 5891.941080589139, 5904.645721256738, 5932.436418540232, 5948.672822994777, 5967.358976281557, 5746.885062298814, 5895.882082358329, 5924.822255332347, 5940.227770389908, 5964.761409543569, 5741.196232527366, 5742.913856292243, 5743.798967036134, 5746.195532625352, 5856.4143585641095, 5607.383187849415, 5659.320881494247, 5720.942790572208, 5758.992176369203, 5789.8263052108505, 5935.34711181761, 5955.736820008369, 5958.672273024852, 5964.880702385841, 5984.14491507634, 4089.1208390196252, 4153.771542565188, 4158.189153115113, 4158.875233742992, 4160.334346504545, 5688.886222275449, 5789.073748200268, 5801.3038435388025, 5826.359100499027, 5833.708314584339, 5585.536967080436, 5588.441155884379, 5604.719764011865, 5609.0, 5618.7190640467, 5401.8919621606565, 5558.638688485235, 5617.8033768817895, 5636.577256705846, 5653.236813030353, 5534.944650553443, 5571.9442805571425, 5585.134304182858, 5589.357223919302, 5597.160425935979, 5561.5272701820795, 5594.86012849682, 5668.7732490701555, 5678.744456499385, 5683.840140746655, 5305.559442656421, 5529.861753456195, 5537.473939975695, 5549.780087964847, 5550.307156317362], "value": 4227.385632987951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.419506151871, 643.314869663808, 676.9729210831567, 692.9653517324134, 727.7198278662713, 13807.378667959942, 14624.634384140389, 15388.461403850868, 15472.149031803247, 15542.37830486782, 13669.65825854354, 13886.4445422183, 13887.305634718248, 13895.0, 13902.0, 799.5202878273034, 818.9222023907719, 819.8565251081067, 820.5815034332503, 820.745568873648, 663.1611012069711, 781.7185813107277, 804.7947773317795, 810.5622963599678, 812.9918700813005, 853.4282031039219, 855.170484629908, 855.5764896376303, 855.9186877246651, 855.9229669329759, 838.7316058861136, 839.4291881520563, 840.7393707950555, 848.8726690996369, 849.049065047145, 499.5239068552455, 596.1177457363127, 611.2573223533384, 613.1569092497815, 615.7321565119188, 13525.18848869071, 13528.526501572398, 13549.661258468617, 13551.661208469768, 13560.728785424237, 13106.148100373444, 13752.243626600533, 13802.37889294984, 13804.723905521934, 13869.105630107164, 12102.636920892388, 12145.453454594475, 12154.453049612788, 12324.383780811013, 12544.184627999151, 4310.3534469829465, 4338.848140315074, 4362.9965108025335, 4479.61923236522, 4515.525869783658, 87268.0, 88640.0, 89095.0, 89792.5510372444, 90679.0, 10457.581696732197, 10548.630797922036, 10563.366198027989, 10765.13878889687, 10852.565897364175, 20273.18907243723, 20295.797042029684, 20302.492437689176, 20318.59362812765, 20330.796692033186, 7930.722424715107, 8025.5585942773705, 8305.252527272574, 8313.542755148404, 8335.708250211213, 4245.702800803914, 4288.678349123766, 4437.33439984005, 4456.0, 4457.465104187519, 3195.6165260168927, 3249.7237734792334, 3267.0, 3290.68738469845, 3292.654271301527, 572.3789688188363, 573.9225204597409, 589.3782059926733, 616.9228846394201, 626.0421555020826, 623.3517142172091, 651.081974416071, 681.4412182010802, 718.8346680263569, 770.942179336552, 9669.806603867883, 9674.75813104664, 9701.0, 9768.724888560098, 9771.804563908681, 610.6702380714453, 627.5607075047485, 670.7283550162192, 700.6041586503711, 730.9451791115688, 4413.883888725469, 4426.579474949875, 4717.834875779331, 4803.759812009455, 4842.733649649233, 125518.0, 125850.37074814568, 125897.0, 128421.0, 131302.34348828194, 63295.0, 97215.51392242993, 101551.49224253831, 114345.0, 116050.0, 89941.55029224812, 91433.54283228541, 91453.0, 93096.53451732697, 97868.0, 8697.130286971253, 8874.112588741074, 8882.555872206492, 8904.643814247358, 8995.100489950952, 55551.0, 56143.43856561382, 56516.43483565112, 58510.7074464625, 60180.39819601923, 79416.0, 80012.1992680441, 82322.58838706008, 82875.0, 84478.57760711157, 11221.382823944761, 11233.943830280796, 11478.655640330804, 11680.0, 12164.39178041112, 12797.0, 12871.613851584467, 13111.934440327737, 13413.530526431528, 13542.390592423168, 11614.0, 11737.178397512092, 12187.451564679433, 12218.009760153502, 12264.693382665504, 12111.757764844477, 12272.693182670504, 12511.499540018298, 12649.596437517659, 12650.177738446971, 11938.224015439317, 12077.094217933865, 12269.509219631114, 12439.315837629018, 12850.357482126043, 8890.244329232088, 8900.510471924106, 9320.813583728423, 9567.665131720356, 9568.378055426376, 8602.612882420432, 8789.319257626485, 8813.2949364052, 9750.60997560118, 9805.117539421486], "value": 7300.318211195559, "unit": "score"}], "name": "dromaeo_css", "value": 7020.314896257715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 128.0, 111.0, 113.0, 112.0, 114.0, 111.0, 110.0, 111.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 144.0, 177.0, 121.0, 155.0, 142.0, 120.0, 174.0, 120.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 175.0, 77.0, 75.0, 75.0, 74.0, 161.0, 77.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 140.0, 82.0, 82.0, 83.0, 149.0, 81.0, 82.0, 140.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 55.0, 53.0, 54.0, 54.0, 57.0, 54.0, 54.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 79.0, 83.0, 83.0, 79.0, 79.0, 79.0, 79.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 134.0, 121.0, 122.0, 126.0, 122.0, 130.0, 130.0, 166.0, 125.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 161.0, 166.0, 167.0, 164.0, 165.0, 166.0, 164.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 66.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1525.9, "alertThreshold": 2.0}]} 16:27:02 INFO - Return code: 0 16:27:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:27:02 INFO - # TBPL SUCCESS # 16:27:02 INFO - Running post-action listener: _resource_record_post_action 16:27:02 INFO - [mozharness: 2016-08-26 23:27:02.561316Z] Finished run-tests step (success) 16:27:02 INFO - Running post-run listener: _resource_record_post_run 16:27:02 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418467840; Read time: 12; Write time: 783080 16:27:02 INFO - TinderboxPrint: CPU usage
13.1% 16:27:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:27:02 INFO - TinderboxPrint: I/O write bytes / time
418,467,840 / 783,080 16:27:02 INFO - TinderboxPrint: CPU idle
8,298.5 (86.9%) 16:27:02 INFO - TinderboxPrint: CPU user
1,197.1 (12.5%) 16:27:02 INFO - TinderboxPrint: Swap in / out
0 / 0 16:27:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 118321152; Read time: 0; Write time: 291708 16:27:02 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288858112; Read time: 0; Write time: 489216 16:27:03 INFO - Running post-run listener: _upload_blobber_files 16:27:03 INFO - Blob upload gear active. 16:27:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:03 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 16:27:03 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'] 16:27:03 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 16:27:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:07 INFO - (blobuploader) - INFO - Done attempting. 16:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:07 INFO - (blobuploader) - INFO - Done attempting. 16:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:08 INFO - (blobuploader) - INFO - Done attempting. 16:27:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:08 INFO - Return code: 0 16:27:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:27:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1106c89c5b042dc0e92cd308dbfdeccc4d6b42a017fcde51fa057a31805eb12e962b1fe8f8ef03f1a6b0234a704956843fd84a2de921f9c0612248c91c13292", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3975a15d6d890d7c7eff72d45d9c0802abe27a4f0c74b3434fe03b20bbe710177e9c3263618311b75e2a8916c667cb2f0a06cf1063c156fbc506c2985ae88904", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5fa07a753662d9bc07f664548f7bbdffaf09c7dc839ebfa3ada0d7e035e445737c9874798f7458a4a86e2fae1af53bb213ec8a2817e9853da985eca3c3a8630"} 16:27:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:27:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:27:08 INFO - Contents: 16:27:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1106c89c5b042dc0e92cd308dbfdeccc4d6b42a017fcde51fa057a31805eb12e962b1fe8f8ef03f1a6b0234a704956843fd84a2de921f9c0612248c91c13292", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3975a15d6d890d7c7eff72d45d9c0802abe27a4f0c74b3434fe03b20bbe710177e9c3263618311b75e2a8916c667cb2f0a06cf1063c156fbc506c2985ae88904", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5fa07a753662d9bc07f664548f7bbdffaf09c7dc839ebfa3ada0d7e035e445737c9874798f7458a4a86e2fae1af53bb213ec8a2817e9853da985eca3c3a8630"} 16:27:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:08 INFO - Copying logs to upload dir... 16:27:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:27:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.508292 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-26 16:27:08.331597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 16:27:08.335529) ========= 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-1472250551.177609-1594240334 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/f1106c89c5b042dc0e92cd308dbfdeccc4d6b42a017fcde51fa057a31805eb12e962b1fe8f8ef03f1a6b0234a704956843fd84a2de921f9c0612248c91c13292", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3975a15d6d890d7c7eff72d45d9c0802abe27a4f0c74b3434fe03b20bbe710177e9c3263618311b75e2a8916c667cb2f0a06cf1063c156fbc506c2985ae88904", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5fa07a753662d9bc07f664548f7bbdffaf09c7dc839ebfa3ada0d7e035e445737c9874798f7458a4a86e2fae1af53bb213ec8a2817e9853da985eca3c3a8630"} build_url:https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/Xh5-ZxKERpSBERBG0mSlfw/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/f1106c89c5b042dc0e92cd308dbfdeccc4d6b42a017fcde51fa057a31805eb12e962b1fe8f8ef03f1a6b0234a704956843fd84a2de921f9c0612248c91c13292", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3975a15d6d890d7c7eff72d45d9c0802abe27a4f0c74b3434fe03b20bbe710177e9c3263618311b75e2a8916c667cb2f0a06cf1063c156fbc506c2985ae88904", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5fa07a753662d9bc07f664548f7bbdffaf09c7dc839ebfa3ada0d7e035e445737c9874798f7458a4a86e2fae1af53bb213ec8a2817e9853da985eca3c3a8630"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 16:27:08.361411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:27:08.361791) ========= 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-1472250551.177609-1594240334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004358 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 16:27:08.444160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 16:27:08.444538) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 16:27:08.444863) ========= ========= Total master_lag: 0.36 =========