builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1471621816.29 results: success (0) buildid: 20160819082023 builduid: a147b3169d6448e9b50184c4c725ecf2 revision: 4d92551f854b80764c7b010c76043920c28c8e35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:16.294592) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:16.295030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-08-19 08:50:16.299478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-08-19 08:50:35.344369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:35.344689) ========= 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-1471621753.367762-940893069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 08:50:35-- 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-19 08:50:35 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124228 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:35.540697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:35.541026) ========= 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-1471621753.367762-940893069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016216 ========= master_lag: 0.47 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:36.031004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:36.031412) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d92551f854b80764c7b010c76043920c28c8e35 --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 4d92551f854b80764c7b010c76043920c28c8e35 --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-1471621753.367762-940893069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 08:50:36,456 truncating revision to first 12 chars 2016-08-19 08:50:36,456 Setting DEBUG logging. 2016-08-19 08:50:36,456 attempt 1/10 2016-08-19 08:50:36,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d92551f854b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 08:50:36,757 unpacking tar archive at: fx-team-4d92551f854b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638873 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:36.697358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:36.697718) ========= script_repo_revision: 4d92551f854b80764c7b010c76043920c28c8e35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:36.701763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:36.702136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:36.722482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-19 08:50:36.722775) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1471621753.367762-940893069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:50:37 INFO - MultiFileLogger online at 20160819 08:50:37 in /builds/slave/test 08:50:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:50:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:37 INFO - {'append_to_log': False, 08:50:37 INFO - 'base_work_dir': '/builds/slave/test', 08:50:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:50:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:37 INFO - 'branch': 'Fx-Team-Non-PGO', 08:50:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:37 INFO - 'config_files': ('talos/linux_config.py',), 08:50:37 INFO - 'default_actions': ('clobber', 08:50:37 INFO - 'read-buildbot-config', 08:50:37 INFO - 'download-and-extract', 08:50:37 INFO - 'populate-webroot', 08:50:37 INFO - 'create-virtualenv', 08:50:37 INFO - 'install', 08:50:37 INFO - 'run-tests'), 08:50:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:37 INFO - 'download_minidump_stackwalk': True, 08:50:37 INFO - 'download_symbols': 'ondemand', 08:50:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:37 INFO - 'installer_path': 'installer.exe', 08:50:37 INFO - 'log_level': 'info', 08:50:37 INFO - 'log_name': 'talos', 08:50:37 INFO - 'log_to_console': True, 08:50:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:50:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:50:37 INFO - 'opt_config_files': (), 08:50:37 INFO - 'pip_index': False, 08:50:37 INFO - 'sps_profile': False, 08:50:37 INFO - 'sps_profile_interval': 0, 08:50:37 INFO - 'suite': 'dromaeojs', 08:50:37 INFO - 'system_bits': '32', 08:50:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:37 INFO - 'title': 'talos-linux64-ix-032', 08:50:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:37 INFO - 'use_talos_json': True, 08:50:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:37 INFO - 'work_dir': 'build'} 08:50:37 INFO - [mozharness: 2016-08-19 15:50:37.246628Z] Running clobber step. 08:50:37 INFO - Running pre-action listener: _resource_record_pre_action 08:50:37 INFO - Running main action method: clobber 08:50:37 INFO - rmtree: /builds/slave/test/build 08:50:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:37 INFO - Running post-action listener: _resource_record_post_action 08:50:37 INFO - [mozharness: 2016-08-19 15:50:37.714317Z] Finished clobber step (success) 08:50:37 INFO - [mozharness: 2016-08-19 15:50:37.714419Z] Running read-buildbot-config step. 08:50:37 INFO - Running pre-action listener: _resource_record_pre_action 08:50:37 INFO - Running main action method: read_buildbot_config 08:50:37 INFO - Using buildbot properties: 08:50:37 INFO - { 08:50:37 INFO - "project": "", 08:50:37 INFO - "product": "firefox", 08:50:37 INFO - "script_repo_revision": "production", 08:50:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:50:37 INFO - "repository": "", 08:50:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:50:37 INFO - "buildid": "20160819082023", 08:50:37 INFO - "pgo_build": "False", 08:50:37 INFO - "basedir": "/builds/slave/test", 08:50:37 INFO - "buildnumber": 2103, 08:50:37 INFO - "slavename": "talos-linux64-ix-032", 08:50:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:50:37 INFO - "platform": "ubuntu64_hw", 08:50:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:50:37 INFO - "branch": "fx-team", 08:50:37 INFO - "repo_path": "integration/fx-team", 08:50:37 INFO - "revision": "4d92551f854b80764c7b010c76043920c28c8e35", 08:50:37 INFO - "stage_platform": "linux64", 08:50:37 INFO - "builduid": "a147b3169d6448e9b50184c4c725ecf2", 08:50:37 INFO - "slavebuilddir": "test" 08:50:37 INFO - } 08:50:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:50:37 INFO - Running post-action listener: _resource_record_post_action 08:50:37 INFO - [mozharness: 2016-08-19 15:50:37.716856Z] Finished read-buildbot-config step (success) 08:50:37 INFO - [mozharness: 2016-08-19 15:50:37.716947Z] Running download-and-extract step. 08:50:37 INFO - Running pre-action listener: _resource_record_pre_action 08:50:37 INFO - Running main action method: download_and_extract 08:50:37 INFO - mkdir: /builds/slave/test/build/tests 08:50:37 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')]} 08:50:37 INFO - trying https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:50:37 INFO - Downloading https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:38 INFO - Downloaded 1361 bytes. 08:50:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:50:38 INFO - Using the following test package requirements: 08:50:38 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:50:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:50:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:50:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'jsshell-linux-x86_64.zip'], 08:50:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:50:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:50:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:50:38 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:50:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:50:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:50:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:38 INFO - trying https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:50:38 INFO - Downloading https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:39 INFO - Downloaded 20328569 bytes. 08:50:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:50:43 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 08:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:43 INFO - trying https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:50:43 INFO - Downloading https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:44 INFO - Downloaded 20328569 bytes. 08:50:44 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 08:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:48 INFO - trying https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:50:48 INFO - Downloading https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:49 INFO - Downloaded 14413981 bytes. 08:50:49 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 08:50:50 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')]} 08:50:50 INFO - trying https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:50:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:50:51 INFO - Downloaded 55767154 bytes. 08:50:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:50:51 INFO - mkdir: /builds/slave/test/properties 08:50:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:50:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:50:51 INFO - Contents: 08:50:51 INFO - build_url:https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:50:51 INFO - Running post-action listener: _resource_record_post_action 08:50:51 INFO - Running post-action listener: set_extra_try_arguments 08:50:51 INFO - [mozharness: 2016-08-19 15:50:51.931095Z] Finished download-and-extract step (success) 08:50:51 INFO - [mozharness: 2016-08-19 15:50:51.931319Z] Running populate-webroot step. 08:50:51 INFO - Running pre-action listener: _resource_record_pre_action 08:50:51 INFO - Running main action method: populate_webroot 08:50:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:50:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:50:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:50:51 INFO - '--tppagecycles', 08:50:51 INFO - '7'], 08:50:51 INFO - 'tests': ['tsvgm']}}, 08:50:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:50:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:50:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:50:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:50:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['damp', 'tps']}, 08:50:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'tests': ['damp', 'tps']}, 08:50:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['dromaeo_dom']}, 08:50:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:50:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['basic_compositor_video']}, 08:50:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:50:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['a11yr', 08:50:51 INFO - 'ts_paint', 08:50:51 INFO - 'tpaint', 08:50:51 INFO - 'sessionrestore', 08:50:51 INFO - 'sessionrestore_no_auto_restore', 08:50:51 INFO - 'tabpaint']}, 08:50:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:50:51 INFO - 'ts_paint', 08:50:51 INFO - 'tpaint', 08:50:51 INFO - 'sessionrestore', 08:50:51 INFO - 'sessionrestore_no_auto_restore', 08:50:51 INFO - 'tabpaint']}, 08:50:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:50:51 INFO - 'ts_paint', 08:50:51 INFO - 'tpaint', 08:50:51 INFO - 'sessionrestore', 08:50:51 INFO - 'sessionrestore_no_auto_restore', 08:50:51 INFO - 'tabpaint']}, 08:50:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:50:51 INFO - 'ts_paint', 08:50:51 INFO - 'tpaint', 08:50:51 INFO - 'sessionrestore', 08:50:51 INFO - 'sessionrestore_no_auto_restore', 08:50:51 INFO - 'tabpaint']}, 08:50:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['a11yr', 08:50:51 INFO - 'ts_paint', 08:50:51 INFO - 'tpaint', 08:50:51 INFO - 'sessionrestore', 08:50:51 INFO - 'sessionrestore_no_auto_restore', 08:50:51 INFO - 'tabpaint']}, 08:50:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['a11yr', 08:50:51 INFO - 'ts_paint', 08:50:51 INFO - 'tpaint', 08:50:51 INFO - 'sessionrestore', 08:50:51 INFO - 'sessionrestore_no_auto_restore', 08:50:51 INFO - 'tabpaint']}, 08:50:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['tsvgx', 08:50:51 INFO - 'tsvgr_opacity', 08:50:51 INFO - 'tart', 08:50:51 INFO - 'tscrollx', 08:50:51 INFO - 'cart']}, 08:50:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:50:51 INFO - 'tsvgr_opacity', 08:50:51 INFO - 'tart', 08:50:51 INFO - 'tscrollx', 08:50:51 INFO - 'cart']}, 08:50:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'talos_options': ['--disable-e10s'], 08:50:51 INFO - 'tests': ['tp5o']}, 08:50:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'tests': ['tp5o']}, 08:50:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'talos_options': ['--disable-e10s', 08:50:51 INFO - '--xperf_path', 08:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:51 INFO - 'tests': ['tp5n']}, 08:50:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:51 INFO - 'talos_options': ['--xperf_path', 08:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:51 INFO - 'tests': ['tp5n']}}, 08:50:51 INFO - 'talos.zip': {'path': '', 08:50:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:50:51 INFO - Running post-action listener: _resource_record_post_action 08:50:51 INFO - [mozharness: 2016-08-19 15:50:51.948164Z] Finished populate-webroot step (success) 08:50:51 INFO - [mozharness: 2016-08-19 15:50:51.948252Z] Running create-virtualenv step. 08:50:51 INFO - Running pre-action listener: _resource_record_pre_action 08:50:51 INFO - Running main action method: create_virtualenv 08:50:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:50:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:50:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:50:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:50:52 INFO - Using real prefix '/usr' 08:50:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:50:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:50:54 INFO - Installing pip.................done. 08:50:54 INFO - Return code: 0 08:50:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:50: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', 'pip>=1.5'] in /builds/slave/test/build 08:50: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 pip>=1.5 08:50:54 INFO - Using env: {'DISPLAY': ':0', 08:50:54 INFO - 'HOME': '/home/cltbld', 08:50:54 INFO - 'LANG': 'en_US.UTF-8', 08:50:54 INFO - 'LANGUAGE': 'en_US:en', 08:50:54 INFO - 'LOGNAME': 'cltbld', 08:50:54 INFO - 'MAIL': '/var/mail/cltbld', 08:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:54 INFO - 'MOZ_NO_REMOTE': '1', 08:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:54 INFO - 'NO_EM_RESTART': '1', 08:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:54 INFO - 'PWD': '/builds/slave/test', 08:50:54 INFO - 'SHELL': '/bin/bash', 08:50:54 INFO - 'SHLVL': '1', 08:50:54 INFO - 'TERM': 'linux', 08:50:54 INFO - 'TMOUT': '86400', 08:50:54 INFO - 'USER': 'cltbld', 08:50:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:54 INFO - '_': '/tools/buildbot/bin/python'} 08:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:50:54 INFO - Cleaning up... 08:50:54 INFO - Return code: 0 08:50:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', '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 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:50: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 psutil>=3.1.1 08:50:54 INFO - Using env: {'DISPLAY': ':0', 08:50:54 INFO - 'HOME': '/home/cltbld', 08:50:54 INFO - 'LANG': 'en_US.UTF-8', 08:50:54 INFO - 'LANGUAGE': 'en_US:en', 08:50:54 INFO - 'LOGNAME': 'cltbld', 08:50:54 INFO - 'MAIL': '/var/mail/cltbld', 08:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:54 INFO - 'MOZ_NO_REMOTE': '1', 08:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:54 INFO - 'NO_EM_RESTART': '1', 08:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:54 INFO - 'PWD': '/builds/slave/test', 08:50:54 INFO - 'SHELL': '/bin/bash', 08:50:54 INFO - 'SHLVL': '1', 08:50:54 INFO - 'TERM': 'linux', 08:50:54 INFO - 'TMOUT': '86400', 08:50:54 INFO - 'USER': 'cltbld', 08:50:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:54 INFO - '_': '/tools/buildbot/bin/python'} 08:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:54 INFO - Downloading/unpacking psutil>=3.1.1 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:56 INFO - Installing collected packages: psutil 08:50:56 INFO - Running setup.py install for psutil 08:50:57 INFO - building 'psutil._psutil_linux' extension 08:50:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:50:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:50:57 INFO - building 'psutil._psutil_posix' extension 08:50:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:50:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:57 INFO - Successfully installed psutil 08:50:57 INFO - Cleaning up... 08:50:57 INFO - Return code: 0 08:50:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:50:57 INFO - Using env: {'DISPLAY': ':0', 08:50:57 INFO - 'HOME': '/home/cltbld', 08:50:57 INFO - 'LANG': 'en_US.UTF-8', 08:50:57 INFO - 'LANGUAGE': 'en_US:en', 08:50:57 INFO - 'LOGNAME': 'cltbld', 08:50:57 INFO - 'MAIL': '/var/mail/cltbld', 08:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:57 INFO - 'MOZ_NO_REMOTE': '1', 08:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:57 INFO - 'NO_EM_RESTART': '1', 08:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:57 INFO - 'PWD': '/builds/slave/test', 08:50:57 INFO - 'SHELL': '/bin/bash', 08:50:57 INFO - 'SHLVL': '1', 08:50:57 INFO - 'TERM': 'linux', 08:50:57 INFO - 'TMOUT': '86400', 08:50:57 INFO - 'USER': 'cltbld', 08:50:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:57 INFO - '_': '/tools/buildbot/bin/python'} 08:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:59 INFO - Installing collected packages: mozsystemmonitor 08:50:59 INFO - Running setup.py install for mozsystemmonitor 08:50:59 INFO - Successfully installed mozsystemmonitor 08:50:59 INFO - Cleaning up... 08:50:59 INFO - Return code: 0 08:50:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:50:59 INFO - Using env: {'DISPLAY': ':0', 08:50:59 INFO - 'HOME': '/home/cltbld', 08:50:59 INFO - 'LANG': 'en_US.UTF-8', 08:50:59 INFO - 'LANGUAGE': 'en_US:en', 08:50:59 INFO - 'LOGNAME': 'cltbld', 08:50:59 INFO - 'MAIL': '/var/mail/cltbld', 08:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:59 INFO - 'MOZ_NO_REMOTE': '1', 08:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:59 INFO - 'NO_EM_RESTART': '1', 08:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:59 INFO - 'PWD': '/builds/slave/test', 08:50:59 INFO - 'SHELL': '/bin/bash', 08:50:59 INFO - 'SHLVL': '1', 08:50:59 INFO - 'TERM': 'linux', 08:50:59 INFO - 'TMOUT': '86400', 08:50:59 INFO - 'USER': 'cltbld', 08:50:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:59 INFO - '_': '/tools/buildbot/bin/python'} 08:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:00 INFO - Downloading/unpacking jsonschema==2.5.1 08:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:02 INFO - warning: no files found matching '*.txt' 08:51:02 INFO - no previously-included directories found matching 'build' 08:51:02 INFO - no previously-included directories found matching 'dist' 08:51:02 INFO - no previously-included directories found matching '.git*' 08:51:02 INFO - Installing collected packages: jsonschema, functools32 08:51:02 INFO - Running setup.py install for functools32 08:51:02 INFO - warning: no files found matching '*.txt' 08:51:02 INFO - no previously-included directories found matching 'build' 08:51:02 INFO - no previously-included directories found matching 'dist' 08:51:02 INFO - no previously-included directories found matching '.git*' 08:51:02 INFO - Successfully installed jsonschema functools32 08:51:02 INFO - Cleaning up... 08:51:02 INFO - Return code: 0 08:51:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51:02 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')]} 08:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:02 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')]} 08:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:02 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 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:02 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 08:51:02 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 08:51:02 INFO - Using env: {'DISPLAY': ':0', 08:51:02 INFO - 'HOME': '/home/cltbld', 08:51:02 INFO - 'LANG': 'en_US.UTF-8', 08:51:02 INFO - 'LANGUAGE': 'en_US:en', 08:51:02 INFO - 'LOGNAME': 'cltbld', 08:51:02 INFO - 'MAIL': '/var/mail/cltbld', 08:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:02 INFO - 'MOZ_NO_REMOTE': '1', 08:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:02 INFO - 'NO_EM_RESTART': '1', 08:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:02 INFO - 'PWD': '/builds/slave/test', 08:51:02 INFO - 'SHELL': '/bin/bash', 08:51:02 INFO - 'SHLVL': '1', 08:51:02 INFO - 'TERM': 'linux', 08:51:02 INFO - 'TMOUT': '86400', 08:51:02 INFO - 'USER': 'cltbld', 08:51:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:02 INFO - '_': '/tools/buildbot/bin/python'} 08:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:02 INFO - Cleaning up... 08:51:02 INFO - Return code: 0 08:51:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:02 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')]} 08:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:02 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')]} 08:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:02 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 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:51:02 INFO - Using env: {'DISPLAY': ':0', 08:51:02 INFO - 'HOME': '/home/cltbld', 08:51:02 INFO - 'LANG': 'en_US.UTF-8', 08:51:02 INFO - 'LANGUAGE': 'en_US:en', 08:51:02 INFO - 'LOGNAME': 'cltbld', 08:51:02 INFO - 'MAIL': '/var/mail/cltbld', 08:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:02 INFO - 'MOZ_NO_REMOTE': '1', 08:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:02 INFO - 'NO_EM_RESTART': '1', 08:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:02 INFO - 'PWD': '/builds/slave/test', 08:51:02 INFO - 'SHELL': '/bin/bash', 08:51:02 INFO - 'SHLVL': '1', 08:51:02 INFO - 'TERM': 'linux', 08:51:02 INFO - 'TMOUT': '86400', 08:51:02 INFO - 'USER': 'cltbld', 08:51:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:02 INFO - '_': '/tools/buildbot/bin/python'} 08:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:06 INFO - Downloading docopt-0.6.1.tar.gz 08:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:06 INFO - Running setup.py install for blobuploader 08:51:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:07 INFO - Running setup.py install for requests 08:51:07 INFO - Running setup.py install for docopt 08:51:07 INFO - Successfully installed blobuploader requests docopt 08:51:07 INFO - Cleaning up... 08:51:07 INFO - Return code: 0 08:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:07 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')]} 08:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:07 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')]} 08:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:07 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 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:07 INFO - Using env: {'DISPLAY': ':0', 08:51:07 INFO - 'HOME': '/home/cltbld', 08:51:07 INFO - 'LANG': 'en_US.UTF-8', 08:51:07 INFO - 'LANGUAGE': 'en_US:en', 08:51:07 INFO - 'LOGNAME': 'cltbld', 08:51:07 INFO - 'MAIL': '/var/mail/cltbld', 08:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:07 INFO - 'MOZ_NO_REMOTE': '1', 08:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:07 INFO - 'NO_EM_RESTART': '1', 08:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:07 INFO - 'PWD': '/builds/slave/test', 08:51:07 INFO - 'SHELL': '/bin/bash', 08:51:07 INFO - 'SHLVL': '1', 08:51:07 INFO - 'TERM': 'linux', 08:51:07 INFO - 'TMOUT': '86400', 08:51:07 INFO - 'USER': 'cltbld', 08:51:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:07 INFO - '_': '/tools/buildbot/bin/python'} 08:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:07 INFO - Running setup.py (path:/tmp/pip-wGvHIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:07 INFO - Running setup.py (path:/tmp/pip-7hRcJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:07 INFO - Running setup.py (path:/tmp/pip-CNFRis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:07 INFO - Running setup.py (path:/tmp/pip-okOIwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:08 INFO - Running setup.py (path:/tmp/pip-lk1Lgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:08 INFO - Running setup.py (path:/tmp/pip-ZxvqQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:08 INFO - Running setup.py (path:/tmp/pip-rSPKr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:08 INFO - Running setup.py (path:/tmp/pip-fS5n7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:08 INFO - Running setup.py (path:/tmp/pip-7GpwZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:08 INFO - Running setup.py (path:/tmp/pip-kJXY5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:08 INFO - Running setup.py (path:/tmp/pip-OI1NJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:08 INFO - Running setup.py (path:/tmp/pip-IFNfgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:08 INFO - Running setup.py (path:/tmp/pip-0fF4AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:08 INFO - Running setup.py (path:/tmp/pip-FDaWoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:08 INFO - Running setup.py (path:/tmp/pip-RNi_YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:08 INFO - Running setup.py (path:/tmp/pip-e0x8KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:08 INFO - Running setup.py (path:/tmp/pip-zm8S_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:08 INFO - Running setup.py install for manifestparser 08:51:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Running setup.py install for mozcrash 08:51:09 INFO - Running setup.py install for mozdebug 08:51:09 INFO - Running setup.py install for mozdevice 08:51:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Running setup.py install for mozfile 08:51:09 INFO - Running setup.py install for mozhttpd 08:51:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Running setup.py install for mozinfo 08:51:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Running setup.py install for mozInstall 08:51:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:09 INFO - Running setup.py install for mozleak 08:51:09 INFO - Running setup.py install for mozlog 08:51:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:10 INFO - Running setup.py install for moznetwork 08:51:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:10 INFO - Running setup.py install for mozprocess 08:51:10 INFO - Running setup.py install for mozprofile 08:51:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:10 INFO - Running setup.py install for mozrunner 08:51:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:10 INFO - Running setup.py install for mozscreenshot 08:51:10 INFO - Running setup.py install for moztest 08:51:10 INFO - Running setup.py install for mozversion 08:51:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:10 INFO - Cleaning up... 08:51:10 INFO - Return code: 0 08:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:10 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')]} 08:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:10 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')]} 08:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:10 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 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:10 INFO - Using env: {'DISPLAY': ':0', 08:51:10 INFO - 'HOME': '/home/cltbld', 08:51:10 INFO - 'LANG': 'en_US.UTF-8', 08:51:10 INFO - 'LANGUAGE': 'en_US:en', 08:51:10 INFO - 'LOGNAME': 'cltbld', 08:51:10 INFO - 'MAIL': '/var/mail/cltbld', 08:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:10 INFO - 'MOZ_NO_REMOTE': '1', 08:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:10 INFO - 'NO_EM_RESTART': '1', 08:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:10 INFO - 'PWD': '/builds/slave/test', 08:51:10 INFO - 'SHELL': '/bin/bash', 08:51:10 INFO - 'SHLVL': '1', 08:51:10 INFO - 'TERM': 'linux', 08:51:10 INFO - 'TMOUT': '86400', 08:51:10 INFO - 'USER': 'cltbld', 08:51:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:10 INFO - '_': '/tools/buildbot/bin/python'} 08:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:11 INFO - Running setup.py (path:/tmp/pip-lttRRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:11 INFO - Running setup.py (path:/tmp/pip-C28PRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:11 INFO - Running setup.py (path:/tmp/pip-2RKdCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:11 INFO - Running setup.py (path:/tmp/pip-OIumwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:11 INFO - Running setup.py (path:/tmp/pip-ngzK_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:11 INFO - Running setup.py (path:/tmp/pip-JDBRDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:11 INFO - Running setup.py (path:/tmp/pip-lulN0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:11 INFO - Running setup.py (path:/tmp/pip-Lp04iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:11 INFO - Running setup.py (path:/tmp/pip-3g8Cwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:11 INFO - Running setup.py (path:/tmp/pip-SiFbgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:11 INFO - Running setup.py (path:/tmp/pip-N0GGDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:11 INFO - Running setup.py (path:/tmp/pip-hZI4Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:11 INFO - Running setup.py (path:/tmp/pip-SbXg2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:11 INFO - Running setup.py (path:/tmp/pip-62x6ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:12 INFO - Running setup.py (path:/tmp/pip-LURn_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:12 INFO - Running setup.py (path:/tmp/pip-12qSKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:12 INFO - Running setup.py (path:/tmp/pip-s9LNjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:14 INFO - Downloading blessings-1.6.tar.gz 08:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:14 INFO - Installing collected packages: blessings 08:51:14 INFO - Running setup.py install for blessings 08:51:14 INFO - Successfully installed blessings 08:51:14 INFO - Cleaning up... 08:51:14 INFO - Return code: 0 08:51:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:14 INFO - Reading from file tmpfile_stdout 08:51:14 INFO - Current package versions: 08:51:14 INFO - argparse == 1.2.1 08:51:14 INFO - blessings == 1.6 08:51:14 INFO - blobuploader == 1.2.4 08:51:14 INFO - docopt == 0.6.1 08:51:14 INFO - functools32 == 3.2.3-2 08:51:14 INFO - jsonschema == 2.5.1 08:51:14 INFO - manifestparser == 1.1 08:51:14 INFO - mozInstall == 1.12 08:51:14 INFO - mozcrash == 0.17 08:51:14 INFO - mozdebug == 0.1 08:51:14 INFO - mozdevice == 0.48 08:51:14 INFO - mozfile == 1.2 08:51:14 INFO - mozhttpd == 0.7 08:51:14 INFO - mozinfo == 0.9 08:51:14 INFO - mozleak == 0.1 08:51:14 INFO - mozlog == 3.3 08:51:14 INFO - moznetwork == 0.27 08:51:14 INFO - mozprocess == 0.23 08:51:14 INFO - mozprofile == 0.28 08:51:14 INFO - mozrunner == 6.12 08:51:14 INFO - mozscreenshot == 0.1 08:51:14 INFO - mozsystemmonitor == 0.3 08:51:14 INFO - moztest == 0.7 08:51:14 INFO - mozversion == 1.4 08:51:14 INFO - psutil == 3.1.1 08:51:14 INFO - requests == 1.2.3 08:51:14 INFO - wsgiref == 0.1.2 08:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:14 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 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:14 INFO - Using env: {'DISPLAY': ':0', 08:51:14 INFO - 'HOME': '/home/cltbld', 08:51:14 INFO - 'LANG': 'en_US.UTF-8', 08:51:14 INFO - 'LANGUAGE': 'en_US:en', 08:51:14 INFO - 'LOGNAME': 'cltbld', 08:51:14 INFO - 'MAIL': '/var/mail/cltbld', 08:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:14 INFO - 'MOZ_NO_REMOTE': '1', 08:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:14 INFO - 'NO_EM_RESTART': '1', 08:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:14 INFO - 'PWD': '/builds/slave/test', 08:51:14 INFO - 'SHELL': '/bin/bash', 08:51:14 INFO - 'SHLVL': '1', 08:51:14 INFO - 'TERM': 'linux', 08:51:14 INFO - 'TMOUT': '86400', 08:51:14 INFO - 'USER': 'cltbld', 08:51:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:14 INFO - '_': '/tools/buildbot/bin/python'} 08:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:14 INFO - Cleaning up... 08:51:14 INFO - Return code: 0 08:51:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:14 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 0x7f562fa80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, '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-1471621753.367762-940893069', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:51:14 INFO - Using env: {'DISPLAY': ':0', 08:51:14 INFO - 'HOME': '/home/cltbld', 08:51:14 INFO - 'LANG': 'en_US.UTF-8', 08:51:14 INFO - 'LANGUAGE': 'en_US:en', 08:51:14 INFO - 'LOGNAME': 'cltbld', 08:51:14 INFO - 'MAIL': '/var/mail/cltbld', 08:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:14 INFO - 'MOZ_NO_REMOTE': '1', 08:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:14 INFO - 'NO_EM_RESTART': '1', 08:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:14 INFO - 'PWD': '/builds/slave/test', 08:51:14 INFO - 'SHELL': '/bin/bash', 08:51:14 INFO - 'SHLVL': '1', 08:51:14 INFO - 'TERM': 'linux', 08:51:14 INFO - 'TMOUT': '86400', 08:51:14 INFO - 'USER': 'cltbld', 08:51:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:14 INFO - '_': '/tools/buildbot/bin/python'} 08:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:15 INFO - Cleaning up... 08:51:15 INFO - Return code: 0 08:51:15 INFO - Running post-action listener: _resource_record_post_action 08:51:15 INFO - Running post-action listener: _start_resource_monitoring 08:51:15 INFO - Starting resource monitoring. 08:51:15 INFO - [mozharness: 2016-08-19 15:51:15.112055Z] Finished create-virtualenv step (success) 08:51:15 INFO - [mozharness: 2016-08-19 15:51:15.112516Z] Running install step. 08:51:15 INFO - Running pre-action listener: _resource_record_pre_action 08:51:15 INFO - Running main action method: install 08:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:15 INFO - Reading from file tmpfile_stdout 08:51:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:15 INFO - Reading from file tmpfile_stdout 08:51:15 INFO - Output received: 08:51:15 INFO - Usage: mozinstall [options] installer 08:51:15 INFO - Options: 08:51:15 INFO - -h, --help show this help message and exit 08:51:15 INFO - -d DEST, --destination=DEST 08:51:15 INFO - Directory to install application into. [default: 08:51:15 INFO - "/builds/slave/test"] 08:51:15 INFO - --app=APP Application being installed. [default: firefox] 08:51:15 INFO - mkdir: /builds/slave/test/build/application 08:51:15 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'] 08:51:15 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 08:51:31 INFO - Reading from file tmpfile_stdout 08:51:31 INFO - Output received: 08:51:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:51:31 INFO - Running post-action listener: _resource_record_post_action 08:51:31 INFO - [mozharness: 2016-08-19 15:51:31.488108Z] Finished install step (success) 08:51:31 INFO - [mozharness: 2016-08-19 15:51:31.488358Z] Running run-tests step. 08:51:31 INFO - Running pre-action listener: _resource_record_pre_action 08:51:31 INFO - Running main action method: run_tests 08:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:31 INFO - Python 2.7.3 08:51:31 INFO - Return code: 0 08:51:31 INFO - grabbing minidump binary from tooltool 08:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:31 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 0x17a0090>, '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 0x17a39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a3e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:51:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:51:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:51:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:31 INFO - Return code: 0 08:51:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:51:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:51:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:51:31 INFO - Using env: {'DISPLAY': ':0', 08:51:31 INFO - 'HOME': '/home/cltbld', 08:51:31 INFO - 'LANG': 'en_US.UTF-8', 08:51:31 INFO - 'LANGUAGE': 'en_US:en', 08:51:31 INFO - 'LOGNAME': 'cltbld', 08:51:31 INFO - 'MAIL': '/var/mail/cltbld', 08:51:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:31 INFO - 'MOZ_NO_REMOTE': '1', 08:51:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:31 INFO - 'NO_EM_RESTART': '1', 08:51:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:31 INFO - 'PWD': '/builds/slave/test', 08:51:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:31 INFO - 'SHELL': '/bin/bash', 08:51:31 INFO - 'SHLVL': '1', 08:51:31 INFO - 'TERM': 'linux', 08:51:31 INFO - 'TMOUT': '86400', 08:51:31 INFO - 'USER': 'cltbld', 08:51:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471621753.367762-940893069', 08:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:31 INFO - '_': '/tools/buildbot/bin/python'} 08:51:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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 08:51:31 INFO - mozversion application_buildid: 20160819082023 08:51:31 INFO - mozversion application_changeset: 4d92551f854b80764c7b010c76043920c28c8e35 08:51:31 INFO - mozversion application_display_name: Nightly 08:51:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:31 INFO - mozversion application_name: Firefox 08:51:31 INFO - mozversion application_remotingname: firefox 08:51:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:51:31 INFO - mozversion application_vendor: Mozilla 08:51:31 INFO - mozversion application_version: 51.0a1 08:51:31 INFO - mozversion platform_buildid: 20160819082023 08:51:31 INFO - mozversion platform_changeset: 4d92551f854b80764c7b010c76043920c28c8e35 08:51:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:51:31 INFO - mozversion platform_version: 51.0a1 08:51:31 INFO - using testdate: 1471621891 08:51:31 INFO - actual date: 1471621891 08:51:31 INFO - starting webserver on 'localhost:37730' 08:51:31 INFO - SUITE-START | Running 2 tests 08:51:31 INFO - TEST-START | dromaeo_css 08:51:31 INFO - operating with platform_type : linux_ 08:51:31 INFO - Initialising browser for dromaeo_css test... 08:51:31 INFO - TEST-INFO | started process 13540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65YPnm/profile http://localhost:37730/getInfo.html) 08:51:36 INFO - PROCESS | 13540 | __metrics Screen width/height:1600/1200 08:51:36 INFO - PROCESS | 13540 | colorDepth:24 08:51:36 INFO - PROCESS | 13540 | Browser inner width/height: 1024/697 08:51:36 INFO - PROCESS | 13540 | __metrics 08:51:36 INFO - PROCESS | 13540 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:51:36 INFO - PROCESS | 13540 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:37 INFO - PROCESS | 13540 | console.error: PushService: 08:51:37 INFO - PROCESS | 13540 | stateChangeProcessEnqueue: Error transitioning state 08:51:37 INFO - PROCESS | 13540 | UnknownError 08:51:38 INFO - TEST-INFO | 13540: exit 0 08:51:38 INFO - Browser initialized. 08:51:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:51:38 INFO - TEST-INFO | started process 13622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65YPnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:50 INFO - PROCESS | 13622 | RSS: Main: 157241344 08:51:50 INFO - PROCESS | 13622 | 08:52:42 INFO - PROCESS | 13622 | 1471621962087 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:54:53 INFO - PROCESS | 13622 | Cycle 1(1): loaded http://localhost:37730/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37730/tests/dromaeo/cssquery-ext.html) 08:54:54 INFO - PROCESS | 13622 | RSS: Main: 232124416 08:54:54 INFO - PROCESS | 13622 | 08:57:57 INFO - PROCESS | 13622 | Cycle 1(1): loaded http://localhost:37730/tests/dromaeo/cssquery-ext.html (next: http://localhost:37730/tests/dromaeo/cssquery-jquery.html) 08:57:57 INFO - PROCESS | 13622 | RSS: Main: 242462720 08:57:57 INFO - PROCESS | 13622 | 09:01:00 INFO - PROCESS | 13622 | Cycle 1(1): loaded http://localhost:37730/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37730/tests/dromaeo/cssquery-mootools.html) 09:01:00 INFO - PROCESS | 13622 | RSS: Main: 188383232 09:01:00 INFO - PROCESS | 13622 | 09:04:03 INFO - PROCESS | 13622 | Cycle 1(1): loaded http://localhost:37730/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37730/tests/dromaeo/cssquery-prototype.html) 09:04:03 INFO - PROCESS | 13622 | RSS: Main: 188600320 09:04:03 INFO - PROCESS | 13622 | 09:07:06 INFO - PROCESS | 13622 | Cycle 1(1): loaded http://localhost:37730/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37730/tests/dromaeo/cssquery-yui.html) 09:07:07 INFO - PROCESS | 13622 | RSS: Main: 188985344 09:07:07 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | Cycle 1(1): loaded http://localhost:37730/tests/dromaeo/cssquery-yui.html (next: http://localhost:37730/tests/dromaeo/cssquery-dojo.html) 09:10:10 INFO - PROCESS | 13622 | RSS: Main: 281702400 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | __start_tp_report 09:10:10 INFO - PROCESS | 13622 | _x_x_mozilla_page_load 09:10:10 INFO - PROCESS | 13622 | _x_x_mozilla_page_load_details 09:10:10 INFO - PROCESS | 13622 | |i|pagename|runs| 09:10:10 INFO - PROCESS | 13622 | |0;dojo.html;2575.6394104825326;2591;2605.7263987281335;2611.7127116017236;2620.240130362195;4534.863954081375;4571.862844114682;4599.126166028453;4676.275177347512;4699.459562150354;4550.79521421536;4596.35651008859;4603.562661547156;4627.051454451837;4661.347411362403;4262.744235345874;4263.424437700917;4326.264535029037;4333.2416827055295;4348.630366418858;4299.075698724773;4321.308590625501;4333.523312435629;4351.151525452538;4355.412019377391;4135.731177473484;4335.653147748172;4342.609165175118;4359.891002724926;4390.978045109786;4165.208610364021;4197.664186865043;4204.747715137101;4218.388333691628;4249.107687385653;4217.894552636178;4225.070484493406;4294.205571969195;4295;4298.075913678574;4528.750918699503;4665.393498845162;4669.579737823612;4690.7654617269;4692.436907571079;4928.482509336504;4972.428170760372;4977.104121258172;5039.798408063673;5040.395152581714;5003.341545888907;5040.420351659533;5042.268871013719;5043.445221025684;5059.443461219263;4564.858785303674;4590.724556526619;4727.409073865732;4727.645426592951;4747.454042785124;5036.445990940993;5112.6421150519855;5128.640995130305;5129.769160387791;5140.485951404829;4898.240772680169;4929.7781599828095;4936.160852655057;4936.6297527685565;4937;4848.466668666444;5001.399832020181;5003.824866129668;5006.374203224597;5010.273510341053;4816.181249187576;4844.297576851337;4847.975760121177;4912.263160525949;4915.238138088602;4868.95131048685;4904.852854414374;4905.9754701226975;4913.336699545587;4916.3362946001835;4181.623653871166;4182.686298527562;4185.644220241314;4189.371594260885;4190.727602705814;3593.1196856770257;3637.472566477899;3658.579263384692;3673.2837096766407;3712.1462063725494;4298.828046878152;4299.204647140289;4302.806373713128;4306.870793876189;4312.5903039211225;5021.924671129936;5024.246363045572;5027.773750181251;5031.698098114125;5033.823816166417;4123.9381409278885;4199.328107502785;4217.304144816071;4223.598758117974;4291.270484017725;4463.598276155161;4476.529964353761;4479.70881892676;4482.977585112054;4485.753283569435;4735.550122738335;4749.477557468745;4749.548792864673;4751.453582838018;4754.1204877098535;4810.086083644096;4915.582175515121;4951.430585482572;4971.751412429437;5022.1211288023715;4765.4996225395835;4766.428028636586;4777.0684716479955;4778.37881075458;4781.952180478151;4964.553190212898;4971.726555039508;4973.5523802857915;4979.502049794992;4980.825671101494;4856.271559266138;4912.7543622818;4921.557059864629;4973.577245934136;5038.647294689336;4887.242477416006;4889.193283108248;4899;4900.215965445512;4900.705957642553;4867.9269810952155;4872.4153101628035;4876.853694389174;4877.000214955997;4880.463149053672;4609.239475486641;4719.976400117977;4734.479207287264;4746.169420351355;4796.736179510161;4900.8774780630765;4901.436334821541;4922.360093187863;4923.753812309442;4927.605791536596;4814.398200224972;4815.590674792682;4824;4826.58973987215;4827.541383568555 09:10:10 INFO - PROCESS | 13622 | |1;ext.html;553.504613371033;557.0919401375758;559.9132134519149;569.6582050769541;570.989348852531;37701.245975080485;39353;39494;43055.35416968748;43075.35386969198;40032;40788;40921.59078409222;41009.38485922714;41042.38436423456;7616.733414330486;7764.417668674872;7764.495307805003;7765.961170194141;7770.0287464067;7644.770656880302;7756.650950707203;7765.339946104588;7770.533767973911;7771.067471903351;7761.689532418696;7780.221977802231;7802;7803.5708036057995;7812.570308633051;7721.884171737428;7756.263155000266;7760.185180556074;7764.534127952341;7768.145503994528;7284.817879553;7346;7350;7353.77938661841;7353.889691654629;31522;31767.36465270705;31792.841035794674;31802.840985795156;31898.840505797554;2881.899133530337;2896.652401711787;2994.475966705818;3074.8616312265776;3166.4458719724184;28208.717912820815;28708.282292942633;28757.85621071881;28867.855660721772;28997.42005159885;3322.568066151409;3407.5399821024093;3410.897673069812;3427.657234276577;3435.1412146963257;243361;243542;243587;244494;244742.99999999822;43566;43634;43716.3442548362;43838.34242486365;43841.34237986433;31919.680803192135;32781.18047048843;32822.507662385084;50932.49067509352;51200.48799511957;12413.193142445713;12523.18228398603;12536.623901282976;12544.435500402504;12554.937225313815;9304.30217733659;9378.90621093794;9379.390339627902;9382.0617938207;9385.62457501706;17477;17564.209610567556;17593.20830562602;17632.823671763374;17734.645307093786;6741.258461569223;6792.592444453348;6905.447564194852;6906.377001404666;6949.409300209438;746.5073051785795;863.6545381847186;894.6689724801865;946.1768261612441;964.7009427077628;26166.86916565405;27479;28106.156815295573;28501.86479487255;28504.429911401658;924.9352545321763;948.0188005414363;974.936629119105;996.9451680157661;999.6201443451587;13645.181289122485;14617.92691036538;14649.414023439156;14846.925765371105;15001.849981500263;363506;365567;366153;367125;369334;46755;47289.290660640116;47365.76317118392;47369.763151184714;47392.28911566329;1147.942602869853;1156.346664134778;1178.721087619942;1179.929204247748;1207.7463732616072;26161;27030.459390812466;27051;27638.170854874385;27748.86125569359;41007.1798564033;41388.1722365557;41388.586114139674;41390.37914431346;41399.58600413957;307158;308060;308150;308874;309156;22030;22657.660135098315;22773.31680049601;22780.886095569414;24796.752032479446;39728.40407393949;40138.1972360557;40248.597514024485;40579.18841623092;41439.37840932328;32056.459634742943;34818.65181348255;35005.47491787574;35594.64405356017;35870.282594348486;34574.481382779784;34764.30471390609;34835;35036.12409689778;35302.29395412026;29699.55450668285;29975.250618733833;34719.82640086884;35274.11814704653;35477.29045419129;29676.81292748266;31889.840550797097;32569.674303256663;32791.67208327886;32886.342273153925;24905.87547062253;25242.873785630953;25310;25399.36501587475;25718.61422078633 09:10:10 INFO - PROCESS | 13622 | |2;jquery.html;359.2975732443074;370.3814629568621;376.7212262925435;379.2150248984603;379.6829647244551;15765.448209312677;17272.91363543182;17483.91258043711;17585.824141758578;17696.82303176968;13553.661158471043;14236.430542778277;14307.499237526688;14326.498572549963;14354.64113397163;4490.618297444713;4722.622190224791;4755.952440475586;4800.735959522225;4803.231482962727;3519.630438803927;4749.382580264561;4785.976070119662;5235.450277720842;5520.309961254843;5562.582806289524;5563.638363506379;5566.137248726433;5570.610057295991;5574.052411090104;5356.464353564632;5460.208269800896;5489.039418101816;5502.724863756836;5581.748821303051;5335.439778823206;5338.172583249564;5341.839744807662;5342.439043900374;5342.973285133588;15462.845371546253;20468.181272749072;20814.85394221483;20839.89580052105;21021;1854.554906822353;1892.5268682829292;1903.200655724599;1970.9605807883906;2361.893714782822;9188.770280742969;9372.812543749154;9500.857487137699;9824.361416507976;9825.606975720963;1694.1373668036895;1717.8625709943174;1773.2286455391816;1782.97325540117;1838.834504894566;65598.3440165597;66980.95757072781;68004.31995680078;68573;70461;9983.251256155672;10250.743731406774;10260.640877569249;10274.075333220046;10334.431606261578;11062.889371106186;13751.174929504261;13764.65588360299;13791.241481718402;13800.585982420544;6284.37156284377;6467.902981455282;6646.96676516624;6670.199576050905;6680.732770689118;6234.750609975641;6253.624782513064;6387.489000879918;6400.55196136266;6416.165898433173;3702.870399536057;3765.9435108473394;3772.773633581994;3812.942805857914;3883.728139030241;1678.7817583714038;1807.2770891643447;1818.2817786974072;1864.683003889342;1911.8470522358177;717.5443593318176;789.6367670871349;840.7057529864499;848.4957127065181;921.1433366968649;16641.833581664272;16989.830101699074;17369.47891563255;17776.111194440226;17982.37061702834;794.8966634337614;795.9283664470225;826.6982551368827;842.5702891525243;873.9825203496022;9439.480828554359;9632.27757918159;9886.406815590944;9907;9997.600095996078;372175;383549;384955;385303;385347;48047.519524805;53471.732641336544;82275;82276.58861705773;85745.57127214324;852.4160949749441;876.6011464783509;882.5190271302156;888.3248730964384;922.2207234886645;15612.4535641252;15895.920520397323;16310.510684679479;16570.751438728188;16573.41993030238;36918.26163476769;37076.62923370732;37266;37728.622713773606;38437;50086.499135008184;50551.74724126356;51404;52376.73811630918;52483;7293.38006269473;7481.139668938142;7499.137599176164;7639.503432276884;7802.648880800264;6267.059941008885;7564.8487030260185;8599.8198679692;11074.169437292396;11483.966443020168;9399.530023498934;9493;9908.950455247677;10271.691849244535;10402.947985260025;7512.962435187789;8151.79620509492;10578.471076445992;10783.083437907551;10940.507677154706;10200.183985281308;10208;10803.891961080288;10885.619003334845;10920.18098642589;7810.960945195237;7831.921680783119;7841.4118941078505;7931.682732690628;8007.1592482788465;9177.467597208375;10199.796004080024;10214.846777298199;10376.792464150523;10420.166386688896 09:10:10 INFO - PROCESS | 13622 | |3;mootools.html;1327.5088217359578;1376.9449222031117;1398.7062716829466;1599.4641794998674;1626.4957863062452;7189.784306470808;7712.0745510538745;7720.845583088335;7737.806554836125;7745.612719364038;6488.156539649851;7131.7503887363955;7456.105267367923;7460.142083660381;7607.353374963121;2133.0294715904265;2141.550274442361;2163.8701677899376;2168.0677308757226;2171.0338899189865;2096.6121267565472;2127.319257837493;2203.4271089516683;2203.7575866654734;2205.4817117977263;2163.286115581854;2177.8693278403266;2179.9564008719817;2180.9781902180935;2184.6832209329636;2080.448681099517;2095.5808838232415;2096.1091536097097;2105.2842033708534;2116.5237821490196;2061.3815855243365;2076.927307544229;2091.780363061887;2091.98954005229;2100.6953991671276;7530.1340345859835;7551.546907185587;7607.581583012932;7620.6951721931055;7641.579713115776;4041.2725709372303;4151.335786274181;4151.398047283157;4154.189932963073;4155.812988415499;2769.2246171072134;2847.1031625038045;2904.9273768155754;2907.651081870189;2915.620969273981;881.4226681523612;951.743029382063;958.2812890332251;964.0744884910495;964.864918911353;10183.38899666015;10240.129588984944;10245.743856403575;10250.077493025738;10285.074343309063;3842.4044273137706;4001.15975645112;4130.855420060284;4170.9582904171175;4194.517630472535;8683.869741953877;8694.347923905605;8746.51894145828;8762.211400973816;8776.429532080394;4308.073764140725;4316.136772645484;4318.201132790444;4351.912961740811;4367.694261401672;3468.8265586720563;3702.7222958278235;3899.434581985596;3908.9218215636097;3917.5298964124486;3462.221000274918;3534.6111927687934;3637.8726744563814;3647.598764135943;3686.631336866292;1181.7931861924128;1195.7488927325185;1199.7840388729937;1209.8729633388543;1211.3035004872233;685.8045457044718;737.1927739125649;825.471698113208;829.369679043931;878.3456325037888;4968.981358821433;5051.090803655377;5128.564072053842;5186.873381913398;5203.713795741271;829.4152622401193;841.7390608911257;884.4781578868499;899.4648184330313;910.6812615584624;3400.880969166067;3473.565804274466;3635.2002559436883;3650;3717.8698745544316;8726.607302671395;9232.492212928219;9271.119243671841;9293.860592091123;9306.581203845843;9132.634694612274;9141.81716365669;9210.309226808016;9235.307351948632;9235.353525253167;6593.175853018372;6800.591964482147;6865.107536020385;7010.509264351548;7024.859502810017;5218.112920803548;5255;5336.573074154136;5384.865378365572;5540.722963851872;8590.226879580869;8642.740717778477;8650.956745216234;8671.262942649946;8765.035846057057;8126;8483.872741908754;8500;8684.34867384936;8748.868766968373;5689.402612725604;5849.444302791228;6306.905396418965;6440.8389790255615;6472.093906852951;6942.132233470817;7007.7196912122945;7085.610291434021;7089.113860767404;7123.074000379917;6323;6332.746690132527;6442.549021568445;6477.935220647733;6555.344465553407;6311.2426508819235;6339.366063393623;6466.870662586816;6475.64383958868;6496.935030649633;5858.9121163181735;5956.791512297049;5959.28488581373;5961.374055724086;5966.2840459143445;4566.543345665407;4599.2871104978785;4610.423697037871;4620.145273124483;4661.627069834337;4435.733855968652;4523.705959112647;4590.495045544921;4624.28323609841;4691.179043667413 09:10:10 INFO - PROCESS | 13622 | |4;prototype.html;293.11040990593546;301.3039877882091;303.50680144764743;303.71602551614234;305.2764947075432;4796.472388037318;4797.640176986732;4810.951890481094;4816.446108697496;4839.951600483994;4761.285937062655;4761.45243297021;4763.928541071887;4771.165046116925;4779.139754844126;3575.8927232183078;3664.120611053355;3668.578113516953;3682.1531047859007;3684.5946945835935;3635.0367152704553;3668.1746607013474;3772.735908486407;3787.6591106800383;3802.543694756633;3713.1459764254237;3721.6092310307436;3735.4023356263006;3757.154640205959;3760.341940160461;3604.715389706338;3719.9442008369897;3741.9251614967548;3749.6250374962697;3759.7968650032;3306.2395649000623;3310.4372256716415;3314.552535407713;3322.684344987222;3338.8998330049894;4648.628109751212;4652.953470465286;4654.278586819015;4665.533446655341;4678.929816052762;4264.253755592759;4270.274053410928;4272.487301523806;4281.801095693211;4283.378910058055;4688.859334219979;4945.9258111128365;4998.475160108209;5003.124453220672;5005.474425185376;3559.626239244894;3568.946465803015;3571.089372210096;3592.4790905318846;3592.8383222755037;5238.240455133984;5265.52610265078;5285.894282114375;5290.127129023706;5297.5232229099565;3525.690672609445;3636.4908912752235;3642.2351306225987;3642.8542858285373;3643.981780091083;3671.1372827385544;3678;3693.2059607184583;3697.6672099511175;3710.591834898159;4206.915861682811;4207.663386929038;4226.288353216891;4252.638525725286;4253.8723838284905;4998.4251811042195;5004.649674522749;5023.547880690755;5061.6962982221185;5081.74591270435;1198.3469009389903;1255.8492980842357;1257.559854051093;1269.720661454497;1273.3378643105534;790.328221012135;800.5116878703986;818.7339114787718;825.1830687619333;832.2883934236262;3945.6646185074014;4203.957960420418;4267.509236437787;4462.620677242471;4472.932906006413;5210.791568337224;5211;5212.817551385683;5213.670514018901;5213.791448342024;4467.7319360838455;4475.731456112579;4480.193565158238;4482.103579284156;4489.304157855538;2616.241290025909;2694.4476382341572;2725;2728.863556822151;2744.766694830922;4839.031993765079;4839.879003024882;4858.489858564871;4860.416749990024;4865.056640732306;5239.842804715865;5273.920891186635;5274.604404669665;5284.894302114013;5290.68255904647;4702;4807.471178170398;4841.031793641216;4854.927176092361;4855.975720121377;5098.419489958125;5099.515546023122;5160.561352285098;5175.247945239671;5186.611004174627;5056.7724452399;5069.619778516552;5098.184290513648;5099.158638824552;5118.283440318432;4676.3686902267755;4888.991027357675;4905.730184839868;4914.778834952507;4918.311436398835;3701.592824789325;3781.8865434037025;3793.3551296279147;3794.5067141271456;3816.1985982943893;5213.608979326642;5215.869603259949;5220.060389129993;5222.963044412758;5229.849433124707;4823.9517604824905;5009.524095210949;5034.572061374824;5060.696358218519;5068.113080211022;4976.452590215146;4988.102141614399;4989.176785830297;4992.126377883928;4994.700317980933;4939.901201976012;4954.256861470664;4975.353204083591;4976.278439626306;4991.80032798684;4834.154023045882;4839.2983017461565;4913.263010548303;5036.345275114211;5057.468965758542;4883;4934.925976110433;4942.703437793743;4947.975260123676;4966.379202599675 09:10:10 INFO - PROCESS | 13622 | |5;yui.html;649.870025994801;690.4234963805219;691.6749127909881;702.5433468245636;731.056936551848;12774.42515086821;13765.931170344134;13825.446982120704;13850.584482465518;13852.515161969333;13306.135101218439;13514.864851351484;13520.526781562647;13525.323733813319;13547.932260338685;618.0636335951016;752.6989204318262;755.2938002967229;771.6103367799282;771.972980945667;783.5533745764916;784.5645666655004;786.2491320788662;787.2521104950291;787.4369825574713;826.6775957376628;827.4208054361941;827.8344331133798;828.1221904780951;828.2504333578122;649.8992656138306;665.2715276771927;666.8966310221923;667.4293479075369;818.1613845808035;574.7988204128521;585.4759989809139;585.8008277185777;586.1295975476414;589.2251689028914;13194.538191163263;13194.802077968838;13226.537071202461;13226.933865330708;13237.801432978513;12048;12388.256704597752;12540.561080362235;12729.98160147186;12912.935435322763;9654.613815447374;9796.90203097967;11233.10135189191;11261.887381126166;11377.88622113785;4100.097978444737;4115.1975364803875;4195.265828480004;4239.618434340924;4360;57232.42767572354;59264;59521;59663.80672386528;60040;10416.531256093494;10444.947775261075;10592.947035264928;10784.56861725538;10872.510737016695;16917.154142292835;17006.659866802594;17024.829751702324;17028.233729482203;17048.48854534366;7063.89404158938;7145.82135446618;7183.054947471512;7491.513051651626;7572.2049184835905;3751.981240093782;3816.1413681921345;3837.4435706822915;3975.185087057146;3994.6804255659476;2821.943561128766;2949.4985852405143;2955.8374289414287;2960.511515599945;2961.851907404621;504.1505063967227;507.9796808127634;508.9414717307483;519.0371860199351;521.1843464977298;495.554001398744;549.7526113249054;554.4566325001521;596.7911231069178;620.92548894133;7616.276453736997;8266.917330826735;8324.833503329899;8343.791405214797;8658.956705216433;564.9689316996498;582.8979928512493;585.4789237578558;610.341177750746;610.4170517156106;3768.3217020936495;3797.696184305304;3918.1771827916455;4013.658838998718;4317.287647538184;88864.11135888688;98326.50836745913;99877;101508.49245753724;102095;87355.58632825513;88927.55536222277;90332.54833725789;92070.53964730134;94391.52804236072;55221;77006.61496692593;78896.60551697205;79908.60045699734;83149.16850831415;6845.520813543004;7363.558186508827;7418.616962831965;7443.148150914321;7625.542467451971;30057.398852023274;38715;39998.60001399949;41637.79181104075;42317.78841105775;37365.065873353386;51129;58586;59187.112193318;62906.37093629188;10668.09321207675;11040.447977601249;11192.888071119185;11398.145139114433;11840.230385024946;12726.17279876805;13045.804312935124;13265.66835829112;13550.051496395157;13798.103123296954;11543.095389261014;11691.356975366436;12008.279503229485;12226.20529665569;12227.266364018187;11509.654710358702;12278.631641050782;12300.753984920431;12367.381630918599;12406;11629.651110466699;11925;12814.29521376296;12825.807612886001;12828;9617.519124043909;9687.66093186735;9705.651550215165;9829.361091529028;10648.361098334124;9172.35793494449;9764.951175244363;10067.446290454096;10299.845502317621;10385.688429347132 09:10:10 INFO - PROCESS | 13622 | __end_tp_report 09:10:10 INFO - PROCESS | 13622 | __start_cc_report 09:10:10 INFO - PROCESS | 13622 | _x_x_mozilla_cycle_collect,959 09:10:10 INFO - PROCESS | 13622 | __end_cc_report 09:10:10 INFO - PROCESS | 13622 | __startTimestamp1471623010565__endTimestamp 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | ------- Summary: start ------- 09:10:10 INFO - PROCESS | 13622 | Number of tests: 6 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | [#0] dojo.html Cycles:165 Average:4601.26 Median:4751.45 stddev:488.48 (10.3%) stddev-sans-first:463.41 09:10:10 INFO - PROCESS | 13622 | Values: 2575.6 2591.0 2605.7 2611.7 2620.2 4534.9 4571.9 4599.1 4676.3 4699.5 4550.8 4596.4 4603.6 4627.1 4661.3 4262.7 4263.4 4326.3 4333.2 4348.6 4299.1 4321.3 4333.5 4351.2 4355.4 4135.7 4335.7 4342.6 4359.9 4391.0 4165.2 4197.7 4204.7 4218.4 4249.1 4217.9 4225.1 4294.2 4295.0 4298.1 4528.8 4665.4 4669.6 4690.8 4692.4 4928.5 4972.4 4977.1 5039.8 5040.4 5003.3 5040.4 5042.3 5043.4 5059.4 4564.9 4590.7 4727.4 4727.6 4747.5 5036.4 5112.6 5128.6 5129.8 5140.5 4898.2 4929.8 4936.2 4936.6 4937.0 4848.5 5001.4 5003.8 5006.4 5010.3 4816.2 4844.3 4848.0 4912.3 4915.2 4869.0 4904.9 4906.0 4913.3 4916.3 4181.6 4182.7 4185.6 4189.4 4190.7 3593.1 3637.5 3658.6 3673.3 3712.1 4298.8 4299.2 4302.8 4306.9 4312.6 5021.9 5024.2 5027.8 5031.7 5033.8 4123.9 4199.3 4217.3 4223.6 4291.3 4463.6 4476.5 4479.7 4483.0 4485.8 4735.6 4749.5 4749.5 4751.5 4754.1 4810.1 4915.6 4951.4 4971.8 5022.1 4765.5 4766.4 4777.1 4778.4 4782.0 4964.6 4971.7 4973.6 4979.5 4980.8 4856.3 4912.8 4921.6 4973.6 5038.6 4887.2 4889.2 4899.0 4900.2 4900.7 4867.9 4872.4 4876.9 4877.0 4880.5 4609.2 4720.0 4734.5 4746.2 4796.7 4900.9 4901.4 4922.4 4923.8 4927.6 4814.4 4815.6 4824.0 4826.6 4827.5 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | [#1] ext.html Cycles:180 Average:44998.84 Median:35535.97 stddev:81623.34 (229.7%) stddev-sans-first:81784.10 09:10:10 INFO - PROCESS | 13622 | Values: 553.5 557.1 559.9 569.7 571.0 37701.2 39353.0 39494.0 43055.4 43075.4 40032.0 40788.0 40921.6 41009.4 41042.4 7616.7 7764.4 7764.5 7766.0 7770.0 7644.8 7756.7 7765.3 7770.5 7771.1 7761.7 7780.2 7802.0 7803.6 7812.6 7721.9 7756.3 7760.2 7764.5 7768.1 7284.8 7346.0 7350.0 7353.8 7353.9 31522.0 31767.4 31792.8 31802.8 31898.8 2881.9 2896.7 2994.5 3074.9 3166.4 28208.7 28708.3 28757.9 28867.9 28997.4 3322.6 3407.5 3410.9 3427.7 3435.1 243361.0 243542.0 243587.0 244494.0 244743.0 43566.0 43634.0 43716.3 43838.3 43841.3 31919.7 32781.2 32822.5 50932.5 51200.5 12413.2 12523.2 12536.6 12544.4 12554.9 9304.3 9378.9 9379.4 9382.1 9385.6 17477.0 17564.2 17593.2 17632.8 17734.6 6741.3 6792.6 6905.4 6906.4 6949.4 746.5 863.7 894.7 946.2 964.7 26166.9 27479.0 28106.2 28501.9 28504.4 924.9 948.0 974.9 996.9 999.6 13645.2 14617.9 14649.4 14846.9 15001.8 363506.0 365567.0 366153.0 367125.0 369334.0 46755.0 47289.3 47365.8 47369.8 47392.3 1147.9 1156.3 1178.7 1179.9 1207.7 26161.0 27030.5 27051.0 27638.2 27748.9 41007.2 41388.2 41388.6 41390.4 41399.6 307158.0 308060.0 308150.0 308874.0 309156.0 22030.0 22657.7 22773.3 22780.9 24796.8 39728.4 40138.2 40248.6 40579.2 41439.4 32056.5 34818.7 35005.5 35594.6 35870.3 34574.5 34764.3 34835.0 35036.1 35302.3 29699.6 29975.3 34719.8 35274.1 35477.3 29676.8 31889.8 32569.7 32791.7 32886.3 24905.9 25242.9 25310.0 25399.4 25718.6 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | [#2] jquery.html Cycles:180 Average:23677.42 Median:4793.36 stddev:63117.53 (1316.8%) stddev-sans-first:63270.31 09:10:10 INFO - PROCESS | 13622 | Values: 359.3 370.4 376.7 379.2 379.7 15765.4 17272.9 17483.9 17585.8 17696.8 13553.7 14236.4 14307.5 14326.5 14354.6 4490.6 4722.6 4756.0 4800.7 4803.2 3519.6 4749.4 4786.0 5235.5 5520.3 5562.6 5563.6 5566.1 5570.6 5574.1 5356.5 5460.2 5489.0 5502.7 5581.7 5335.4 5338.2 5341.8 5342.4 5343.0 15462.8 20468.2 20814.9 20839.9 21021.0 1854.6 1892.5 1903.2 1971.0 2361.9 9188.8 9372.8 9500.9 9824.4 9825.6 1694.1 1717.9 1773.2 1783.0 1838.8 65598.3 66981.0 68004.3 68573.0 70461.0 9983.3 10250.7 10260.6 10274.1 10334.4 11062.9 13751.2 13764.7 13791.2 13800.6 6284.4 6467.9 6647.0 6670.2 6680.7 6234.8 6253.6 6387.5 6400.6 6416.2 3702.9 3765.9 3772.8 3812.9 3883.7 1678.8 1807.3 1818.3 1864.7 1911.8 717.5 789.6 840.7 848.5 921.1 16641.8 16989.8 17369.5 17776.1 17982.4 794.9 795.9 826.7 842.6 874.0 9439.5 9632.3 9886.4 9907.0 9997.6 372175.0 383549.0 384955.0 385303.0 385347.0 48047.5 53471.7 82275.0 82276.6 85745.6 852.4 876.6 882.5 888.3 922.2 15612.5 15895.9 16310.5 16570.8 16573.4 36918.3 37076.6 37266.0 37728.6 38437.0 50086.5 50551.7 51404.0 52376.7 52483.0 7293.4 7481.1 7499.1 7639.5 7802.6 6267.1 7564.8 8599.8 11074.2 11484.0 9399.5 9493.0 9909.0 10271.7 10402.9 7513.0 8151.8 10578.5 10783.1 10940.5 10200.2 10208.0 10803.9 10885.6 10920.2 7811.0 7831.9 7841.4 7931.7 8007.2 9177.5 10199.8 10214.8 10376.8 10420.2 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | [#3] mootools.html Cycles:180 Average:4937.07 Median:5236.56 stddev:2729.23 (52.1%) stddev-sans-first:2723.41 09:10:10 INFO - PROCESS | 13622 | Values: 1327.5 1376.9 1398.7 1599.5 1626.5 7189.8 7712.1 7720.8 7737.8 7745.6 6488.2 7131.8 7456.1 7460.1 7607.4 2133.0 2141.6 2163.9 2168.1 2171.0 2096.6 2127.3 2203.4 2203.8 2205.5 2163.3 2177.9 2180.0 2181.0 2184.7 2080.4 2095.6 2096.1 2105.3 2116.5 2061.4 2076.9 2091.8 2092.0 2100.7 7530.1 7551.5 7607.6 7620.7 7641.6 4041.3 4151.3 4151.4 4154.2 4155.8 2769.2 2847.1 2904.9 2907.7 2915.6 881.4 951.7 958.3 964.1 964.9 10183.4 10240.1 10245.7 10250.1 10285.1 3842.4 4001.2 4130.9 4171.0 4194.5 8683.9 8694.3 8746.5 8762.2 8776.4 4308.1 4316.1 4318.2 4351.9 4367.7 3468.8 3702.7 3899.4 3908.9 3917.5 3462.2 3534.6 3637.9 3647.6 3686.6 1181.8 1195.7 1199.8 1209.9 1211.3 685.8 737.2 825.5 829.4 878.3 4969.0 5051.1 5128.6 5186.9 5203.7 829.4 841.7 884.5 899.5 910.7 3400.9 3473.6 3635.2 3650.0 3717.9 8726.6 9232.5 9271.1 9293.9 9306.6 9132.6 9141.8 9210.3 9235.3 9235.4 6593.2 6800.6 6865.1 7010.5 7024.9 5218.1 5255.0 5336.6 5384.9 5540.7 8590.2 8642.7 8651.0 8671.3 8765.0 8126.0 8483.9 8500.0 8684.3 8748.9 5689.4 5849.4 6306.9 6440.8 6472.1 6942.1 7007.7 7085.6 7089.1 7123.1 6323.0 6332.7 6442.5 6477.9 6555.3 6311.2 6339.4 6466.9 6475.6 6496.9 5858.9 5956.8 5959.3 5961.4 5966.3 4566.5 4599.3 4610.4 4620.1 4661.6 4435.7 4523.7 4590.5 4624.3 4691.2 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | [#4] prototype.html Cycles:180 Average:4164.20 Median:4767.55 stddev:1216.97 (25.5%) stddev-sans-first:1185.19 09:10:10 INFO - PROCESS | 13622 | Values: 293.1 301.3 303.5 303.7 305.3 4796.5 4797.6 4811.0 4816.4 4840.0 4761.3 4761.5 4763.9 4771.2 4779.1 3575.9 3664.1 3668.6 3682.2 3684.6 3635.0 3668.2 3772.7 3787.7 3802.5 3713.1 3721.6 3735.4 3757.2 3760.3 3604.7 3719.9 3741.9 3749.6 3759.8 3306.2 3310.4 3314.6 3322.7 3338.9 4648.6 4653.0 4654.3 4665.5 4678.9 4264.3 4270.3 4272.5 4281.8 4283.4 4688.9 4945.9 4998.5 5003.1 5005.5 3559.6 3568.9 3571.1 3592.5 3592.8 5238.2 5265.5 5285.9 5290.1 5297.5 3525.7 3636.5 3642.2 3642.9 3644.0 3671.1 3678.0 3693.2 3697.7 3710.6 4206.9 4207.7 4226.3 4252.6 4253.9 4998.4 5004.6 5023.5 5061.7 5081.7 1198.3 1255.8 1257.6 1269.7 1273.3 790.3 800.5 818.7 825.2 832.3 3945.7 4204.0 4267.5 4462.6 4472.9 5210.8 5211.0 5212.8 5213.7 5213.8 4467.7 4475.7 4480.2 4482.1 4489.3 2616.2 2694.4 2725.0 2728.9 2744.8 4839.0 4839.9 4858.5 4860.4 4865.1 5239.8 5273.9 5274.6 5284.9 5290.7 4702.0 4807.5 4841.0 4854.9 4856.0 5098.4 5099.5 5160.6 5175.2 5186.6 5056.8 5069.6 5098.2 5099.2 5118.3 4676.4 4889.0 4905.7 4914.8 4918.3 3701.6 3781.9 3793.4 3794.5 3816.2 5213.6 5215.9 5220.1 5223.0 5229.8 4824.0 5009.5 5034.6 5060.7 5068.1 4976.5 4988.1 4989.2 4992.1 4994.7 4939.9 4954.3 4975.4 4976.3 4991.8 4834.2 4839.3 4913.3 5036.3 5057.5 4883.0 4934.9 4942.7 4948.0 4966.4 09:10:10 INFO - PROCESS | 13622 | 09:10:10 INFO - PROCESS | 13622 | [#5] yui.html Cycles:180 Average:17525.68 Median:499.85 stddev:25288.98 (5059.3%) stddev-sans-first:25328.17 09:10:10 INFO - PROCESS | 13622 | Values: 649.9 690.4 691.7 702.5 731.1 12774.4 13765.9 13825.4 13850.6 13852.5 13306.1 13514.9 13520.5 13525.3 13547.9 618.1 752.7 755.3 771.6 772.0 783.6 784.6 786.2 787.3 787.4 826.7 827.4 827.8 828.1 828.3 649.9 665.3 666.9 667.4 818.2 574.8 585.5 585.8 586.1 589.2 13194.5 13194.8 13226.5 13226.9 13237.8 12048.0 12388.3 12540.6 12730.0 12912.9 9654.6 9796.9 11233.1 11261.9 11377.9 4100.1 4115.2 4195.3 4239.6 4360.0 57232.4 59264.0 59521.0 59663.8 60040.0 10416.5 10444.9 10592.9 10784.6 10872.5 16917.2 17006.7 17024.8 17028.2 17048.5 7063.9 7145.8 7183.1 7491.5 7572.2 3752.0 3816.1 3837.4 3975.2 3994.7 2821.9 2949.5 2955.8 2960.5 2961.9 504.2 508.0 508.9 519.0 521.2 495.6 549.8 554.5 596.8 620.9 7616.3 8266.9 8324.8 8343.8 8659.0 565.0 582.9 585.5 610.3 610.4 3768.3 3797.7 3918.2 4013.7 4317.3 88864.1 98326.5 99877.0 101508.5 102095.0 87355.6 88927.6 90332.5 92070.5 94391.5 55221.0 77006.6 78896.6 79908.6 83149.2 6845.5 7363.6 7418.6 7443.1 7625.5 30057.4 38715.0 39998.6 41637.8 42317.8 37365.1 51129.0 58586.0 59187.1 62906.4 10668.1 11040.4 11192.9 11398.1 11840.2 12726.2 13045.8 13265.7 13550.1 13798.1 11543.1 11691.4 12008.3 12226.2 12227.3 11509.7 12278.6 12300.8 12367.4 12406.0 11629.7 11925.0 12814.3 12825.8 12828.0 9617.5 9687.7 9705.7 9829.4 10648.4 9172.4 9765.0 10067.4 10299.8 10385.7 09:10:10 INFO - PROCESS | 13622 | -------- Summary: end -------- 09:10:10 INFO - PROCESS | 13622 | 09:10:11 INFO - TEST-INFO | 13622: exit 0 09:10:11 INFO - TEST-OK | dromaeo_css | took 1119683ms 09:10:11 INFO - TEST-START | kraken 09:10:11 INFO - operating with platform_type : linux_ 09:10:11 INFO - Initialising browser for kraken test... 09:10:11 INFO - TEST-INFO | started process 13925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf3UtUy/profile http://localhost:37730/getInfo.html) 09:10:16 INFO - PROCESS | 13925 | __metrics Screen width/height:1600/1200 09:10:16 INFO - PROCESS | 13925 | colorDepth:24 09:10:16 INFO - PROCESS | 13925 | Browser inner width/height: 1024/697 09:10:16 INFO - PROCESS | 13925 | __metrics 09:10:16 INFO - PROCESS | 13925 | 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" 09:10:16 INFO - PROCESS | 13925 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:17 INFO - TEST-INFO | 13925: exit 0 09:10:17 INFO - Browser initialized. 09:10:17 INFO - Running cycle 1/1 for kraken test... 09:10:17 INFO - TEST-INFO | started process 14005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf3UtUy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:29 INFO - PROCESS | 14005 | RSS: Main: 157323264 09:10:29 INFO - PROCESS | 14005 | 09:10:32 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37730/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:33 INFO - PROCESS | 14005 | RSS: Main: 212783104 09:10:33 INFO - PROCESS | 14005 | 09:10:36 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37730/tests/kraken/driver.html?testName=audio-dft) 09:10:36 INFO - PROCESS | 14005 | RSS: Main: 191127552 09:10:36 INFO - PROCESS | 14005 | 09:10:40 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37730/tests/kraken/driver.html?testName=audio-fft) 09:10:40 INFO - PROCESS | 14005 | RSS: Main: 270663680 09:10:40 INFO - PROCESS | 14005 | 09:10:43 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37730/tests/kraken/driver.html?testName=audio-oscillator) 09:10:43 INFO - PROCESS | 14005 | RSS: Main: 180023296 09:10:43 INFO - PROCESS | 14005 | 09:10:45 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37730/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:10:46 INFO - PROCESS | 14005 | RSS: Main: 184664064 09:10:46 INFO - PROCESS | 14005 | 09:10:49 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37730/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:50 INFO - PROCESS | 14005 | RSS: Main: 220971008 09:10:50 INFO - PROCESS | 14005 | 09:10:53 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37730/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:54 INFO - PROCESS | 14005 | RSS: Main: 214937600 09:10:54 INFO - PROCESS | 14005 | 09:10:57 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37730/tests/kraken/driver.html?testName=json-parse-financial) 09:10:58 INFO - PROCESS | 14005 | RSS: Main: 217849856 09:10:58 INFO - PROCESS | 14005 | 09:10:59 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37730/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:00 INFO - PROCESS | 14005 | RSS: Main: 181960704 09:11:00 INFO - PROCESS | 14005 | 09:11:02 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:02 INFO - PROCESS | 14005 | RSS: Main: 189198336 09:11:02 INFO - PROCESS | 14005 | 09:11:04 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:05 INFO - PROCESS | 14005 | RSS: Main: 192696320 09:11:05 INFO - PROCESS | 14005 | 09:11:08 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:09 INFO - PROCESS | 14005 | RSS: Main: 187695104 09:11:09 INFO - PROCESS | 14005 | 09:11:12 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:12 INFO - PROCESS | 14005 | RSS: Main: 191266816 09:11:12 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | Cycle 1(1): loaded http://localhost:37730/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37730/tests/kraken/driver.html?testName=ai-astar) 09:11:14 INFO - PROCESS | 14005 | RSS: Main: 242810880 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | __start_tp_report 09:11:14 INFO - PROCESS | 14005 | _x_x_mozilla_page_load 09:11:14 INFO - PROCESS | 14005 | _x_x_mozilla_page_load_details 09:11:14 INFO - PROCESS | 14005 | |i|pagename|runs| 09:11:14 INFO - PROCESS | 14005 | |0;ai-astar;107;114;116;115;114;116;114;114;115;115 09:11:14 INFO - PROCESS | 14005 | |1;audio-beat-detection;155;120;130;180;125;121;150;131;182;124 09:11:14 INFO - PROCESS | 14005 | |2;audio-dft;162;166;164;163;161;161;161;161;160;162 09:11:14 INFO - PROCESS | 14005 | |3;audio-fft;76;76;78;112;80;77;76;77;103;75 09:11:14 INFO - PROCESS | 14005 | |4;audio-oscillator;87;88;126;87;87;86;132;86;87;130 09:11:14 INFO - PROCESS | 14005 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 09:11:14 INFO - PROCESS | 14005 | |6;imaging-darkroom;146;146;146;147;148;148;148;146;146;147 09:11:14 INFO - PROCESS | 14005 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;96 09:11:14 INFO - PROCESS | 14005 | |8;json-parse-financial;62;63;63;64;63;66;64;64;64;63 09:11:14 INFO - PROCESS | 14005 | |9;json-stringify-tinderbox;65;65;65;65;67;66;66;66;65;67 09:11:14 INFO - PROCESS | 14005 | |10;stanford-crypto-aes;91;84;83;82;91;81;82;83;86;82 09:11:14 INFO - PROCESS | 14005 | |11;stanford-crypto-ccm;138;132;133;134;131;143;134;131;154;136 09:11:14 INFO - PROCESS | 14005 | |12;stanford-crypto-pbkdf2;170;171;172;171;171;173;171;171;169;172 09:11:14 INFO - PROCESS | 14005 | |13;stanford-crypto-sha256-iterative;68;68;68;67;67;68;67;67;68;67 09:11:14 INFO - PROCESS | 14005 | __end_tp_report 09:11:14 INFO - PROCESS | 14005 | __start_cc_report 09:11:14 INFO - PROCESS | 14005 | _x_x_mozilla_cycle_collect,1952 09:11:14 INFO - PROCESS | 14005 | __end_cc_report 09:11:14 INFO - PROCESS | 14005 | __startTimestamp1471623074678__endTimestamp 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | ------- Summary: start ------- 09:11:14 INFO - PROCESS | 14005 | Number of tests: 14 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.58 (2.2%) stddev-sans-first:0.83 09:11:14 INFO - PROCESS | 14005 | Values: 107.0 114.0 116.0 115.0 114.0 116.0 114.0 114.0 115.0 115.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:140.50 stddev:23.76 (16.9%) stddev-sans-first:24.71 09:11:14 INFO - PROCESS | 14005 | Values: 155.0 120.0 130.0 180.0 125.0 121.0 150.0 131.0 182.0 124.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 09:11:14 INFO - PROCESS | 14005 | Values: 162.0 166.0 164.0 163.0 161.0 161.0 161.0 161.0 160.0 162.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.16 (17.2%) stddev-sans-first:13.71 09:11:14 INFO - PROCESS | 14005 | Values: 76.0 76.0 78.0 112.0 80.0 77.0 76.0 77.0 103.0 75.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:87.00 stddev:20.58 (23.7%) stddev-sans-first:21.31 09:11:14 INFO - PROCESS | 14005 | Values: 87.0 88.0 126.0 87.0 87.0 86.0 132.0 86.0 87.0 130.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:11:14 INFO - PROCESS | 14005 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 09:11:14 INFO - PROCESS | 14005 | Values: 146.0 146.0 146.0 147.0 148.0 148.0 148.0 146.0 146.0 147.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:11:14 INFO - PROCESS | 14005 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 96.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:0.97 09:11:14 INFO - PROCESS | 14005 | Values: 62.0 63.0 63.0 64.0 63.0 66.0 64.0 64.0 64.0 63.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 09:11:14 INFO - PROCESS | 14005 | Values: 65.0 65.0 65.0 65.0 67.0 66.0 66.0 66.0 65.0 67.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:3.69 (4.4%) stddev-sans-first:3.07 09:11:14 INFO - PROCESS | 14005 | Values: 91.0 84.0 83.0 82.0 91.0 81.0 82.0 83.0 86.0 82.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:135.00 stddev:7.12 (5.3%) stddev-sans-first:7.54 09:11:14 INFO - PROCESS | 14005 | Values: 138.0 132.0 133.0 134.0 131.0 143.0 134.0 131.0 154.0 136.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.00 stddev:1.10 (0.6%) stddev-sans-first:1.09 09:11:14 INFO - PROCESS | 14005 | Values: 170.0 171.0 172.0 171.0 171.0 173.0 171.0 171.0 169.0 172.0 09:11:14 INFO - PROCESS | 14005 | 09:11:14 INFO - PROCESS | 14005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:11:14 INFO - PROCESS | 14005 | Values: 68.0 68.0 68.0 67.0 67.0 68.0 67.0 67.0 68.0 67.0 09:11:14 INFO - PROCESS | 14005 | -------- Summary: end -------- 09:11:14 INFO - PROCESS | 14005 | 09:11:15 INFO - TEST-INFO | 14005: exit 0 09:11:15 INFO - TEST-OK | kraken | took 64410ms 09:11:15 INFO - SUITE-END | took 1184s 09:11:16 INFO - Completed test suite (00:19:44) 09:11:16 INFO - javascript benchmark 09:11:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.6394104825326, 2591.0, 2605.7263987281335, 2611.7127116017236, 2620.240130362195, 4534.863954081375, 4571.862844114682, 4599.126166028453, 4676.275177347512, 4699.459562150354, 4550.79521421536, 4596.35651008859, 4603.562661547156, 4627.051454451837, 4661.347411362403, 4262.744235345874, 4263.424437700917, 4326.264535029037, 4333.2416827055295, 4348.630366418858, 4299.075698724773, 4321.308590625501, 4333.523312435629, 4351.151525452538, 4355.412019377391, 4135.731177473484, 4335.653147748172, 4342.609165175118, 4359.891002724926, 4390.978045109786, 4165.208610364021, 4197.664186865043, 4204.747715137101, 4218.388333691628, 4249.107687385653, 4217.894552636178, 4225.070484493406, 4294.205571969195, 4295.0, 4298.075913678574, 4528.750918699503, 4665.393498845162, 4669.579737823612, 4690.7654617269, 4692.436907571079, 4928.482509336504, 4972.428170760372, 4977.104121258172, 5039.798408063673, 5040.395152581714, 5003.341545888907, 5040.420351659533, 5042.268871013719, 5043.445221025684, 5059.443461219263, 4564.858785303674, 4590.724556526619, 4727.409073865732, 4727.645426592951, 4747.454042785124, 5036.445990940993, 5112.6421150519855, 5128.640995130305, 5129.769160387791, 5140.485951404829, 4898.240772680169, 4929.7781599828095, 4936.160852655057, 4936.6297527685565, 4937.0, 4848.466668666444, 5001.399832020181, 5003.824866129668, 5006.374203224597, 5010.273510341053, 4816.181249187576, 4844.297576851337, 4847.975760121177, 4912.263160525949, 4915.238138088602, 4868.95131048685, 4904.852854414374, 4905.9754701226975, 4913.336699545587, 4916.3362946001835, 4181.623653871166, 4182.686298527562, 4185.644220241314, 4189.371594260885, 4190.727602705814, 3593.1196856770257, 3637.472566477899, 3658.579263384692, 3673.2837096766407, 3712.1462063725494, 4298.828046878152, 4299.204647140289, 4302.806373713128, 4306.870793876189, 4312.5903039211225, 5021.924671129936, 5024.246363045572, 5027.773750181251, 5031.698098114125, 5033.823816166417, 4123.9381409278885, 4199.328107502785, 4217.304144816071, 4223.598758117974, 4291.270484017725, 4463.598276155161, 4476.529964353761, 4479.70881892676, 4482.977585112054, 4485.753283569435, 4735.550122738335, 4749.477557468745, 4749.548792864673, 4751.453582838018, 4754.1204877098535, 4810.086083644096, 4915.582175515121, 4951.430585482572, 4971.751412429437, 5022.1211288023715, 4765.4996225395835, 4766.428028636586, 4777.0684716479955, 4778.37881075458, 4781.952180478151, 4964.553190212898, 4971.726555039508, 4973.5523802857915, 4979.502049794992, 4980.825671101494, 4856.271559266138, 4912.7543622818, 4921.557059864629, 4973.577245934136, 5038.647294689336, 4887.242477416006, 4889.193283108248, 4899.0, 4900.215965445512, 4900.705957642553, 4867.9269810952155, 4872.4153101628035, 4876.853694389174, 4877.000214955997, 4880.463149053672, 4609.239475486641, 4719.976400117977, 4734.479207287264, 4746.169420351355, 4796.736179510161, 4900.8774780630765, 4901.436334821541, 4922.360093187863, 4923.753812309442, 4927.605791536596, 4814.398200224972, 4815.590674792682, 4824.0, 4826.58973987215, 4827.541383568555], "value": 4569.706148288497, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.504613371033, 557.0919401375758, 559.9132134519149, 569.6582050769541, 570.989348852531, 37701.245975080485, 39353.0, 39494.0, 43055.35416968748, 43075.35386969198, 40032.0, 40788.0, 40921.59078409222, 41009.38485922714, 41042.38436423456, 7616.733414330486, 7764.417668674872, 7764.495307805003, 7765.961170194141, 7770.0287464067, 7644.770656880302, 7756.650950707203, 7765.339946104588, 7770.533767973911, 7771.067471903351, 7761.689532418696, 7780.221977802231, 7802.0, 7803.5708036057995, 7812.570308633051, 7721.884171737428, 7756.263155000266, 7760.185180556074, 7764.534127952341, 7768.145503994528, 7284.817879553, 7346.0, 7350.0, 7353.77938661841, 7353.889691654629, 31522.0, 31767.36465270705, 31792.841035794674, 31802.840985795156, 31898.840505797554, 2881.899133530337, 2896.652401711787, 2994.475966705818, 3074.8616312265776, 3166.4458719724184, 28208.717912820815, 28708.282292942633, 28757.85621071881, 28867.855660721772, 28997.42005159885, 3322.568066151409, 3407.5399821024093, 3410.897673069812, 3427.657234276577, 3435.1412146963257, 243361.0, 243542.0, 243587.0, 244494.0, 244742.99999999822, 43566.0, 43634.0, 43716.3442548362, 43838.34242486365, 43841.34237986433, 31919.680803192135, 32781.18047048843, 32822.507662385084, 50932.49067509352, 51200.48799511957, 12413.193142445713, 12523.18228398603, 12536.623901282976, 12544.435500402504, 12554.937225313815, 9304.30217733659, 9378.90621093794, 9379.390339627902, 9382.0617938207, 9385.62457501706, 17477.0, 17564.209610567556, 17593.20830562602, 17632.823671763374, 17734.645307093786, 6741.258461569223, 6792.592444453348, 6905.447564194852, 6906.377001404666, 6949.409300209438, 746.5073051785795, 863.6545381847186, 894.6689724801865, 946.1768261612441, 964.7009427077628, 26166.86916565405, 27479.0, 28106.156815295573, 28501.86479487255, 28504.429911401658, 924.9352545321763, 948.0188005414363, 974.936629119105, 996.9451680157661, 999.6201443451587, 13645.181289122485, 14617.92691036538, 14649.414023439156, 14846.925765371105, 15001.849981500263, 363506.0, 365567.0, 366153.0, 367125.0, 369334.0, 46755.0, 47289.290660640116, 47365.76317118392, 47369.763151184714, 47392.28911566329, 1147.942602869853, 1156.346664134778, 1178.721087619942, 1179.929204247748, 1207.7463732616072, 26161.0, 27030.459390812466, 27051.0, 27638.170854874385, 27748.86125569359, 41007.1798564033, 41388.1722365557, 41388.586114139674, 41390.37914431346, 41399.58600413957, 307158.0, 308060.0, 308150.0, 308874.0, 309156.0, 22030.0, 22657.660135098315, 22773.31680049601, 22780.886095569414, 24796.752032479446, 39728.40407393949, 40138.1972360557, 40248.597514024485, 40579.18841623092, 41439.37840932328, 32056.459634742943, 34818.65181348255, 35005.47491787574, 35594.64405356017, 35870.282594348486, 34574.481382779784, 34764.30471390609, 34835.0, 35036.12409689778, 35302.29395412026, 29699.55450668285, 29975.250618733833, 34719.82640086884, 35274.11814704653, 35477.29045419129, 29676.81292748266, 31889.840550797097, 32569.674303256663, 32791.67208327886, 32886.342273153925, 24905.87547062253, 25242.873785630953, 25310.0, 25399.36501587475, 25718.61422078633], "value": 16687.710165584886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.2975732443074, 370.3814629568621, 376.7212262925435, 379.2150248984603, 379.6829647244551, 15765.448209312677, 17272.91363543182, 17483.91258043711, 17585.824141758578, 17696.82303176968, 13553.661158471043, 14236.430542778277, 14307.499237526688, 14326.498572549963, 14354.64113397163, 4490.618297444713, 4722.622190224791, 4755.952440475586, 4800.735959522225, 4803.231482962727, 3519.630438803927, 4749.382580264561, 4785.976070119662, 5235.450277720842, 5520.309961254843, 5562.582806289524, 5563.638363506379, 5566.137248726433, 5570.610057295991, 5574.052411090104, 5356.464353564632, 5460.208269800896, 5489.039418101816, 5502.724863756836, 5581.748821303051, 5335.439778823206, 5338.172583249564, 5341.839744807662, 5342.439043900374, 5342.973285133588, 15462.845371546253, 20468.181272749072, 20814.85394221483, 20839.89580052105, 21021.0, 1854.554906822353, 1892.5268682829292, 1903.200655724599, 1970.9605807883906, 2361.893714782822, 9188.770280742969, 9372.812543749154, 9500.857487137699, 9824.361416507976, 9825.606975720963, 1694.1373668036895, 1717.8625709943174, 1773.2286455391816, 1782.97325540117, 1838.834504894566, 65598.3440165597, 66980.95757072781, 68004.31995680078, 68573.0, 70461.0, 9983.251256155672, 10250.743731406774, 10260.640877569249, 10274.075333220046, 10334.431606261578, 11062.889371106186, 13751.174929504261, 13764.65588360299, 13791.241481718402, 13800.585982420544, 6284.37156284377, 6467.902981455282, 6646.96676516624, 6670.199576050905, 6680.732770689118, 6234.750609975641, 6253.624782513064, 6387.489000879918, 6400.55196136266, 6416.165898433173, 3702.870399536057, 3765.9435108473394, 3772.773633581994, 3812.942805857914, 3883.728139030241, 1678.7817583714038, 1807.2770891643447, 1818.2817786974072, 1864.683003889342, 1911.8470522358177, 717.5443593318176, 789.6367670871349, 840.7057529864499, 848.4957127065181, 921.1433366968649, 16641.833581664272, 16989.830101699074, 17369.47891563255, 17776.111194440226, 17982.37061702834, 794.8966634337614, 795.9283664470225, 826.6982551368827, 842.5702891525243, 873.9825203496022, 9439.480828554359, 9632.27757918159, 9886.406815590944, 9907.0, 9997.600095996078, 372175.0, 383549.0, 384955.0, 385303.0, 385347.0, 48047.519524805, 53471.732641336544, 82275.0, 82276.58861705773, 85745.57127214324, 852.4160949749441, 876.6011464783509, 882.5190271302156, 888.3248730964384, 922.2207234886645, 15612.4535641252, 15895.920520397323, 16310.510684679479, 16570.751438728188, 16573.41993030238, 36918.26163476769, 37076.62923370732, 37266.0, 37728.622713773606, 38437.0, 50086.499135008184, 50551.74724126356, 51404.0, 52376.73811630918, 52483.0, 7293.38006269473, 7481.139668938142, 7499.137599176164, 7639.503432276884, 7802.648880800264, 6267.059941008885, 7564.8487030260185, 8599.8198679692, 11074.169437292396, 11483.966443020168, 9399.530023498934, 9493.0, 9908.950455247677, 10271.691849244535, 10402.947985260025, 7512.962435187789, 8151.79620509492, 10578.471076445992, 10783.083437907551, 10940.507677154706, 10200.183985281308, 10208.0, 10803.891961080288, 10885.619003334845, 10920.18098642589, 7810.960945195237, 7831.921680783119, 7841.4118941078505, 7931.682732690628, 8007.1592482788465, 9177.467597208375, 10199.796004080024, 10214.846777298199, 10376.792464150523, 10420.166386688896], "value": 7958.686498068492, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.5088217359578, 1376.9449222031117, 1398.7062716829466, 1599.4641794998674, 1626.4957863062452, 7189.784306470808, 7712.0745510538745, 7720.845583088335, 7737.806554836125, 7745.612719364038, 6488.156539649851, 7131.7503887363955, 7456.105267367923, 7460.142083660381, 7607.353374963121, 2133.0294715904265, 2141.550274442361, 2163.8701677899376, 2168.0677308757226, 2171.0338899189865, 2096.6121267565472, 2127.319257837493, 2203.4271089516683, 2203.7575866654734, 2205.4817117977263, 2163.286115581854, 2177.8693278403266, 2179.9564008719817, 2180.9781902180935, 2184.6832209329636, 2080.448681099517, 2095.5808838232415, 2096.1091536097097, 2105.2842033708534, 2116.5237821490196, 2061.3815855243365, 2076.927307544229, 2091.780363061887, 2091.98954005229, 2100.6953991671276, 7530.1340345859835, 7551.546907185587, 7607.581583012932, 7620.6951721931055, 7641.579713115776, 4041.2725709372303, 4151.335786274181, 4151.398047283157, 4154.189932963073, 4155.812988415499, 2769.2246171072134, 2847.1031625038045, 2904.9273768155754, 2907.651081870189, 2915.620969273981, 881.4226681523612, 951.743029382063, 958.2812890332251, 964.0744884910495, 964.864918911353, 10183.38899666015, 10240.129588984944, 10245.743856403575, 10250.077493025738, 10285.074343309063, 3842.4044273137706, 4001.15975645112, 4130.855420060284, 4170.9582904171175, 4194.517630472535, 8683.869741953877, 8694.347923905605, 8746.51894145828, 8762.211400973816, 8776.429532080394, 4308.073764140725, 4316.136772645484, 4318.201132790444, 4351.912961740811, 4367.694261401672, 3468.8265586720563, 3702.7222958278235, 3899.434581985596, 3908.9218215636097, 3917.5298964124486, 3462.221000274918, 3534.6111927687934, 3637.8726744563814, 3647.598764135943, 3686.631336866292, 1181.7931861924128, 1195.7488927325185, 1199.7840388729937, 1209.8729633388543, 1211.3035004872233, 685.8045457044718, 737.1927739125649, 825.471698113208, 829.369679043931, 878.3456325037888, 4968.981358821433, 5051.090803655377, 5128.564072053842, 5186.873381913398, 5203.713795741271, 829.4152622401193, 841.7390608911257, 884.4781578868499, 899.4648184330313, 910.6812615584624, 3400.880969166067, 3473.565804274466, 3635.2002559436883, 3650.0, 3717.8698745544316, 8726.607302671395, 9232.492212928219, 9271.119243671841, 9293.860592091123, 9306.581203845843, 9132.634694612274, 9141.81716365669, 9210.309226808016, 9235.307351948632, 9235.353525253167, 6593.175853018372, 6800.591964482147, 6865.107536020385, 7010.509264351548, 7024.859502810017, 5218.112920803548, 5255.0, 5336.573074154136, 5384.865378365572, 5540.722963851872, 8590.226879580869, 8642.740717778477, 8650.956745216234, 8671.262942649946, 8765.035846057057, 8126.0, 8483.872741908754, 8500.0, 8684.34867384936, 8748.868766968373, 5689.402612725604, 5849.444302791228, 6306.905396418965, 6440.8389790255615, 6472.093906852951, 6942.132233470817, 7007.7196912122945, 7085.610291434021, 7089.113860767404, 7123.074000379917, 6323.0, 6332.746690132527, 6442.549021568445, 6477.935220647733, 6555.344465553407, 6311.2426508819235, 6339.366063393623, 6466.870662586816, 6475.64383958868, 6496.935030649633, 5858.9121163181735, 5956.791512297049, 5959.28488581373, 5961.374055724086, 5966.2840459143445, 4566.543345665407, 4599.2871104978785, 4610.423697037871, 4620.145273124483, 4661.627069834337, 4435.733855968652, 4523.705959112647, 4590.495045544921, 4624.28323609841, 4691.179043667413], "value": 4007.7489696969506, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.11040990593546, 301.3039877882091, 303.50680144764743, 303.71602551614234, 305.2764947075432, 4796.472388037318, 4797.640176986732, 4810.951890481094, 4816.446108697496, 4839.951600483994, 4761.285937062655, 4761.45243297021, 4763.928541071887, 4771.165046116925, 4779.139754844126, 3575.8927232183078, 3664.120611053355, 3668.578113516953, 3682.1531047859007, 3684.5946945835935, 3635.0367152704553, 3668.1746607013474, 3772.735908486407, 3787.6591106800383, 3802.543694756633, 3713.1459764254237, 3721.6092310307436, 3735.4023356263006, 3757.154640205959, 3760.341940160461, 3604.715389706338, 3719.9442008369897, 3741.9251614967548, 3749.6250374962697, 3759.7968650032, 3306.2395649000623, 3310.4372256716415, 3314.552535407713, 3322.684344987222, 3338.8998330049894, 4648.628109751212, 4652.953470465286, 4654.278586819015, 4665.533446655341, 4678.929816052762, 4264.253755592759, 4270.274053410928, 4272.487301523806, 4281.801095693211, 4283.378910058055, 4688.859334219979, 4945.9258111128365, 4998.475160108209, 5003.124453220672, 5005.474425185376, 3559.626239244894, 3568.946465803015, 3571.089372210096, 3592.4790905318846, 3592.8383222755037, 5238.240455133984, 5265.52610265078, 5285.894282114375, 5290.127129023706, 5297.5232229099565, 3525.690672609445, 3636.4908912752235, 3642.2351306225987, 3642.8542858285373, 3643.981780091083, 3671.1372827385544, 3678.0, 3693.2059607184583, 3697.6672099511175, 3710.591834898159, 4206.915861682811, 4207.663386929038, 4226.288353216891, 4252.638525725286, 4253.8723838284905, 4998.4251811042195, 5004.649674522749, 5023.547880690755, 5061.6962982221185, 5081.74591270435, 1198.3469009389903, 1255.8492980842357, 1257.559854051093, 1269.720661454497, 1273.3378643105534, 790.328221012135, 800.5116878703986, 818.7339114787718, 825.1830687619333, 832.2883934236262, 3945.6646185074014, 4203.957960420418, 4267.509236437787, 4462.620677242471, 4472.932906006413, 5210.791568337224, 5211.0, 5212.817551385683, 5213.670514018901, 5213.791448342024, 4467.7319360838455, 4475.731456112579, 4480.193565158238, 4482.103579284156, 4489.304157855538, 2616.241290025909, 2694.4476382341572, 2725.0, 2728.863556822151, 2744.766694830922, 4839.031993765079, 4839.879003024882, 4858.489858564871, 4860.416749990024, 4865.056640732306, 5239.842804715865, 5273.920891186635, 5274.604404669665, 5284.894302114013, 5290.68255904647, 4702.0, 4807.471178170398, 4841.031793641216, 4854.927176092361, 4855.975720121377, 5098.419489958125, 5099.515546023122, 5160.561352285098, 5175.247945239671, 5186.611004174627, 5056.7724452399, 5069.619778516552, 5098.184290513648, 5099.158638824552, 5118.283440318432, 4676.3686902267755, 4888.991027357675, 4905.730184839868, 4914.778834952507, 4918.311436398835, 3701.592824789325, 3781.8865434037025, 3793.3551296279147, 3794.5067141271456, 3816.1985982943893, 5213.608979326642, 5215.869603259949, 5220.060389129993, 5222.963044412758, 5229.849433124707, 4823.9517604824905, 5009.524095210949, 5034.572061374824, 5060.696358218519, 5068.113080211022, 4976.452590215146, 4988.102141614399, 4989.176785830297, 4992.126377883928, 4994.700317980933, 4939.901201976012, 4954.256861470664, 4975.353204083591, 4976.278439626306, 4991.80032798684, 4834.154023045882, 4839.2983017461565, 4913.263010548303, 5036.345275114211, 5057.468965758542, 4883.0, 4934.925976110433, 4942.703437793743, 4947.975260123676, 4966.379202599675], "value": 3774.9188813089413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.870025994801, 690.4234963805219, 691.6749127909881, 702.5433468245636, 731.056936551848, 12774.42515086821, 13765.931170344134, 13825.446982120704, 13850.584482465518, 13852.515161969333, 13306.135101218439, 13514.864851351484, 13520.526781562647, 13525.323733813319, 13547.932260338685, 618.0636335951016, 752.6989204318262, 755.2938002967229, 771.6103367799282, 771.972980945667, 783.5533745764916, 784.5645666655004, 786.2491320788662, 787.2521104950291, 787.4369825574713, 826.6775957376628, 827.4208054361941, 827.8344331133798, 828.1221904780951, 828.2504333578122, 649.8992656138306, 665.2715276771927, 666.8966310221923, 667.4293479075369, 818.1613845808035, 574.7988204128521, 585.4759989809139, 585.8008277185777, 586.1295975476414, 589.2251689028914, 13194.538191163263, 13194.802077968838, 13226.537071202461, 13226.933865330708, 13237.801432978513, 12048.0, 12388.256704597752, 12540.561080362235, 12729.98160147186, 12912.935435322763, 9654.613815447374, 9796.90203097967, 11233.10135189191, 11261.887381126166, 11377.88622113785, 4100.097978444737, 4115.1975364803875, 4195.265828480004, 4239.618434340924, 4360.0, 57232.42767572354, 59264.0, 59521.0, 59663.80672386528, 60040.0, 10416.531256093494, 10444.947775261075, 10592.947035264928, 10784.56861725538, 10872.510737016695, 16917.154142292835, 17006.659866802594, 17024.829751702324, 17028.233729482203, 17048.48854534366, 7063.89404158938, 7145.82135446618, 7183.054947471512, 7491.513051651626, 7572.2049184835905, 3751.981240093782, 3816.1413681921345, 3837.4435706822915, 3975.185087057146, 3994.6804255659476, 2821.943561128766, 2949.4985852405143, 2955.8374289414287, 2960.511515599945, 2961.851907404621, 504.1505063967227, 507.9796808127634, 508.9414717307483, 519.0371860199351, 521.1843464977298, 495.554001398744, 549.7526113249054, 554.4566325001521, 596.7911231069178, 620.92548894133, 7616.276453736997, 8266.917330826735, 8324.833503329899, 8343.791405214797, 8658.956705216433, 564.9689316996498, 582.8979928512493, 585.4789237578558, 610.341177750746, 610.4170517156106, 3768.3217020936495, 3797.696184305304, 3918.1771827916455, 4013.658838998718, 4317.287647538184, 88864.11135888688, 98326.50836745913, 99877.0, 101508.49245753724, 102095.0, 87355.58632825513, 88927.55536222277, 90332.54833725789, 92070.53964730134, 94391.52804236072, 55221.0, 77006.61496692593, 78896.60551697205, 79908.60045699734, 83149.16850831415, 6845.520813543004, 7363.558186508827, 7418.616962831965, 7443.148150914321, 7625.542467451971, 30057.398852023274, 38715.0, 39998.60001399949, 41637.79181104075, 42317.78841105775, 37365.065873353386, 51129.0, 58586.0, 59187.112193318, 62906.37093629188, 10668.09321207675, 11040.447977601249, 11192.888071119185, 11398.145139114433, 11840.230385024946, 12726.17279876805, 13045.804312935124, 13265.66835829112, 13550.051496395157, 13798.103123296954, 11543.095389261014, 11691.356975366436, 12008.279503229485, 12226.20529665569, 12227.266364018187, 11509.654710358702, 12278.631641050782, 12300.753984920431, 12367.381630918599, 12406.0, 11629.651110466699, 11925.0, 12814.29521376296, 12825.807612886001, 12828.0, 9617.519124043909, 9687.66093186735, 9705.651550215165, 9829.361091529028, 10648.361098334124, 9172.35793494449, 9764.951175244363, 10067.446290454096, 10299.845502317621, 10385.688429347132], "value": 6550.853303560747, "unit": "score"}], "name": "dromaeo_css", "value": 6259.6047502683705, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 116.0, 115.0, 114.0, 116.0, 114.0, 114.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 130.0, 180.0, 125.0, 121.0, 150.0, 131.0, 182.0, 124.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 163.0, 161.0, 161.0, 161.0, 161.0, 160.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 112.0, 80.0, 77.0, 76.0, 77.0, 103.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 126.0, 87.0, 87.0, 86.0, 132.0, 86.0, 87.0, 130.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 148.0, 148.0, 148.0, 146.0, 146.0, 147.0], "value": 146.8, "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, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 63.0, 66.0, 64.0, 64.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 83.0, 82.0, 91.0, 81.0, 82.0, 83.0, 86.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 133.0, 134.0, 131.0, 143.0, 134.0, 131.0, 154.0, 136.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 172.0, 171.0, 171.0, 173.0, 171.0, 171.0, 169.0, 172.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1548.1, "alertThreshold": 2.0}]} 09:11:16 INFO - Return code: 0 09:11:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:16 INFO - # TBPL SUCCESS # 09:11:16 INFO - Running post-action listener: _resource_record_post_action 09:11:16 INFO - [mozharness: 2016-08-19 16:11:16.483925Z] Finished run-tests step (success) 09:11:16 INFO - Running post-run listener: _resource_record_post_run 09:11:16 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 412160000; Read time: 316; Write time: 658484 09:11:16 INFO - TinderboxPrint: CPU usage
13.0% 09:11:16 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 316 09:11:16 INFO - TinderboxPrint: I/O write bytes / time
412,160,000 / 658,484 09:11:16 INFO - TinderboxPrint: CPU idle
8,337.4 (87.0%) 09:11:16 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 09:11:16 INFO - TinderboxPrint: Swap in / out
0 / 0 09:11:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 120782848; Read time: 272; Write time: 227256 09:11:16 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291377152; Read time: 44; Write time: 431228 09:11:17 INFO - Running post-run listener: _upload_blobber_files 09:11:17 INFO - Blob upload gear active. 09:11:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:17 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 09:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:11:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:22 INFO - (blobuploader) - INFO - Done attempting. 09:11:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:23 INFO - (blobuploader) - INFO - Done attempting. 09:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:24 INFO - (blobuploader) - INFO - Done attempting. 09:11:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:24 INFO - Return code: 0 09:11:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c2cf1658a35165490df981b51e557d0b50934aa2e71cc7215e24babc772ed71e4f6835786e81473726f482c5dcecddeb2e7f8ce8b2cf6aacb33dc7111642c453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f0a946b6d472d7bd50cb71037fb61e8e345cde5956e19c0e01eb6273720b0a3da77b0c58411b2fcf0253b2fff9108bd02df4edfa640eb2991c601e9daf17319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a15d6aa6b6a2b8b7f3e38d30d9af901f6ab084e40fb58f25efa03052b59ae0da493b47943f90f87b7aabccbdc1113747cbeaabfebf676baac271091d70282576"} 09:11:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:24 INFO - Contents: 09:11:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c2cf1658a35165490df981b51e557d0b50934aa2e71cc7215e24babc772ed71e4f6835786e81473726f482c5dcecddeb2e7f8ce8b2cf6aacb33dc7111642c453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f0a946b6d472d7bd50cb71037fb61e8e345cde5956e19c0e01eb6273720b0a3da77b0c58411b2fcf0253b2fff9108bd02df4edfa640eb2991c601e9daf17319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a15d6aa6b6a2b8b7f3e38d30d9af901f6ab084e40fb58f25efa03052b59ae0da493b47943f90f87b7aabccbdc1113747cbeaabfebf676baac271091d70282576"} 09:11:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:24 INFO - Copying logs to upload dir... 09:11:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.183079 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-19 09:11:23.927561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 09:11:23.931469) ========= 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-1471621753.367762-940893069 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-Non-PGO/sha512/c2cf1658a35165490df981b51e557d0b50934aa2e71cc7215e24babc772ed71e4f6835786e81473726f482c5dcecddeb2e7f8ce8b2cf6aacb33dc7111642c453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f0a946b6d472d7bd50cb71037fb61e8e345cde5956e19c0e01eb6273720b0a3da77b0c58411b2fcf0253b2fff9108bd02df4edfa640eb2991c601e9daf17319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a15d6aa6b6a2b8b7f3e38d30d9af901f6ab084e40fb58f25efa03052b59ae0da493b47943f90f87b7aabccbdc1113747cbeaabfebf676baac271091d70282576"} build_url:https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/UJNpMseeTGGjy5R9fcFuzQ/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-Non-PGO/sha512/c2cf1658a35165490df981b51e557d0b50934aa2e71cc7215e24babc772ed71e4f6835786e81473726f482c5dcecddeb2e7f8ce8b2cf6aacb33dc7111642c453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f0a946b6d472d7bd50cb71037fb61e8e345cde5956e19c0e01eb6273720b0a3da77b0c58411b2fcf0253b2fff9108bd02df4edfa640eb2991c601e9daf17319", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a15d6aa6b6a2b8b7f3e38d30d9af901f6ab084e40fb58f25efa03052b59ae0da493b47943f90f87b7aabccbdc1113747cbeaabfebf676baac271091d70282576"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 09:11:23.956756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 09:11:23.957124) ========= 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-1471621753.367762-940893069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 09:11:24.040318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 09:11:24.040630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 09:11:24.040920) ========= ========= Total master_lag: 0.69 =========