builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1472611175.71 results: success (0) buildid: 20160830181721 builduid: 202e18ed13f24beea4035d2b07c60355 revision: 506facea63169a29e04eb140663da1730052db64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:35.711593) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:35.712118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:35.712432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:35.740076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:35.740400) ========= 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=af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 19:39: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2016-08-30 19:39:35 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147669 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:35.918649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:35.919032) ========= 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=af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.145849 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:36.077825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:36.078215) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 506facea63169a29e04eb140663da1730052db64 --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 506facea63169a29e04eb140663da1730052db64 --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=af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 19:39:36,145 truncating revision to first 12 chars 2016-08-30 19:39:36,145 Setting DEBUG logging. 2016-08-30 19:39:36,145 attempt 1/10 2016-08-30 19:39:36,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/506facea6316?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 19:39:36,427 unpacking tar archive at: fx-team-506facea6316/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:36.643750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:36.644114) ========= script_repo_revision: 506facea63169a29e04eb140663da1730052db64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:36.644540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:36.644802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 19:39:36.654223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-08-30 19:39:36.654586) ========= /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=af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:39:36 INFO - MultiFileLogger online at 20160830 19:39:36 in /builds/slave/test 19:39:36 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 19:39:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:39:36 INFO - {'append_to_log': False, 19:39:36 INFO - 'base_work_dir': '/builds/slave/test', 19:39:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:39:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:39:36 INFO - 'branch': 'Fx-Team-Non-PGO', 19:39:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:39:36 INFO - 'config_files': ('talos/linux_config.py',), 19:39:36 INFO - 'default_actions': ('clobber', 19:39:36 INFO - 'read-buildbot-config', 19:39:36 INFO - 'download-and-extract', 19:39:36 INFO - 'populate-webroot', 19:39:36 INFO - 'create-virtualenv', 19:39:36 INFO - 'install', 19:39:36 INFO - 'run-tests'), 19:39:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:39:36 INFO - 'download_minidump_stackwalk': True, 19:39:36 INFO - 'download_symbols': 'ondemand', 19:39:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:39:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:39:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:39:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:39:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:39:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:39:36 INFO - 'installer_path': 'installer.exe', 19:39:36 INFO - 'log_level': 'info', 19:39:36 INFO - 'log_name': 'talos', 19:39:36 INFO - 'log_to_console': True, 19:39:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:39:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:39:36 INFO - 'opt_config_files': (), 19:39:36 INFO - 'pip_index': False, 19:39:36 INFO - 'sps_profile': False, 19:39:36 INFO - 'sps_profile_interval': 0, 19:39:36 INFO - 'suite': 'dromaeojs', 19:39:36 INFO - 'system_bits': '32', 19:39:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:39:36 INFO - 'title': 'talos-linux64-ix-020', 19:39:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:39:36 INFO - 'use_talos_json': True, 19:39:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:39:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:39:36 INFO - 'work_dir': 'build'} 19:39:36 INFO - [mozharness: 2016-08-31 02:39:36.920724Z] Running clobber step. 19:39:36 INFO - Running pre-action listener: _resource_record_pre_action 19:39:36 INFO - Running main action method: clobber 19:39:36 INFO - rmtree: /builds/slave/test/build 19:39:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:39:38 INFO - Running post-action listener: _resource_record_post_action 19:39:38 INFO - [mozharness: 2016-08-31 02:39:38.020928Z] Finished clobber step (success) 19:39:38 INFO - [mozharness: 2016-08-31 02:39:38.021031Z] Running read-buildbot-config step. 19:39:38 INFO - Running pre-action listener: _resource_record_pre_action 19:39:38 INFO - Running main action method: read_buildbot_config 19:39:38 INFO - Using buildbot properties: 19:39:38 INFO - { 19:39:38 INFO - "project": "", 19:39:38 INFO - "product": "firefox", 19:39:38 INFO - "script_repo_revision": "production", 19:39:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:39:38 INFO - "repository": "", 19:39:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:39:38 INFO - "buildid": "20160830181721", 19:39:38 INFO - "pgo_build": "False", 19:39:38 INFO - "basedir": "/builds/slave/test", 19:39:38 INFO - "buildnumber": 2127, 19:39:38 INFO - "slavename": "talos-linux64-ix-020", 19:39:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:39:38 INFO - "platform": "ubuntu64_hw", 19:39:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:39:38 INFO - "branch": "fx-team", 19:39:38 INFO - "repo_path": "integration/fx-team", 19:39:38 INFO - "revision": "506facea63169a29e04eb140663da1730052db64", 19:39:38 INFO - "stage_platform": "linux64", 19:39:38 INFO - "builduid": "202e18ed13f24beea4035d2b07c60355", 19:39:38 INFO - "slavebuilddir": "test" 19:39:38 INFO - } 19:39:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:39:38 INFO - Running post-action listener: _resource_record_post_action 19:39:38 INFO - [mozharness: 2016-08-31 02:39:38.023517Z] Finished read-buildbot-config step (success) 19:39:38 INFO - [mozharness: 2016-08-31 02:39:38.023607Z] Running download-and-extract step. 19:39:38 INFO - Running pre-action listener: _resource_record_pre_action 19:39:38 INFO - Running main action method: download_and_extract 19:39:38 INFO - mkdir: /builds/slave/test/build/tests 19:39: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')]} 19:39:38 INFO - trying https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:39:38 INFO - Downloading https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:38 INFO - Downloaded 1361 bytes. 19:39:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:39:38 INFO - Using the following test package requirements: 19:39:38 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:39:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:39:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:39:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'jsshell-linux-x86_64.zip'], 19:39:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:39:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:39:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:39:38 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:39:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:39:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:39:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:39: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')]} 19:39:38 INFO - trying https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:39:38 INFO - Downloading https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:39 INFO - Downloaded 20325955 bytes. 19:39: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 19:39: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 19:39: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')]} 19:39:43 INFO - trying https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:39:43 INFO - Downloading https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:45 INFO - Downloaded 20325955 bytes. 19:39:45 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 19:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:49 INFO - trying https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:39:49 INFO - Downloading https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:50 INFO - Downloaded 14413998 bytes. 19:39:50 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 19:39: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')]} 19:39:50 INFO - trying https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:39:50 INFO - Downloading https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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 19:39:52 INFO - Downloaded 55860768 bytes. 19:39:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:39:52 INFO - mkdir: /builds/slave/test/properties 19:39:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:39:52 INFO - Writing to file /builds/slave/test/properties/build_url 19:39:52 INFO - Contents: 19:39:52 INFO - build_url:https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:39:52 INFO - Running post-action listener: _resource_record_post_action 19:39:52 INFO - Running post-action listener: set_extra_try_arguments 19:39:52 INFO - [mozharness: 2016-08-31 02:39:52.692122Z] Finished download-and-extract step (success) 19:39:52 INFO - [mozharness: 2016-08-31 02:39:52.692351Z] Running populate-webroot step. 19:39:52 INFO - Running pre-action listener: _resource_record_pre_action 19:39:52 INFO - Running main action method: populate_webroot 19:39:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:39:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:39:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:39:52 INFO - '--tppagecycles', 19:39:52 INFO - '7'], 19:39:52 INFO - 'tests': ['tsvgm']}}, 19:39:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:39:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:39:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:39:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:39:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['damp', 'tps']}, 19:39:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'tests': ['damp', 'tps']}, 19:39:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['dromaeo_dom']}, 19:39:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:39:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['basic_compositor_video']}, 19:39:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:39:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['a11yr', 19:39:52 INFO - 'ts_paint', 19:39:52 INFO - 'tpaint', 19:39:52 INFO - 'sessionrestore', 19:39:52 INFO - 'sessionrestore_no_auto_restore', 19:39:52 INFO - 'tabpaint']}, 19:39:52 INFO - 'other-e10s': {'tests': ['a11yr', 19:39:52 INFO - 'ts_paint', 19:39:52 INFO - 'tpaint', 19:39:52 INFO - 'sessionrestore', 19:39:52 INFO - 'sessionrestore_no_auto_restore', 19:39:52 INFO - 'tabpaint']}, 19:39:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:39:52 INFO - 'ts_paint', 19:39:52 INFO - 'tpaint', 19:39:52 INFO - 'sessionrestore', 19:39:52 INFO - 'sessionrestore_no_auto_restore', 19:39:52 INFO - 'tabpaint']}, 19:39:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:39:52 INFO - 'ts_paint', 19:39:52 INFO - 'tpaint', 19:39:52 INFO - 'sessionrestore', 19:39:52 INFO - 'sessionrestore_no_auto_restore', 19:39:52 INFO - 'tabpaint']}, 19:39:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['a11yr', 19:39:52 INFO - 'ts_paint', 19:39:52 INFO - 'tpaint', 19:39:52 INFO - 'sessionrestore', 19:39:52 INFO - 'sessionrestore_no_auto_restore', 19:39:52 INFO - 'tabpaint']}, 19:39:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['a11yr', 19:39:52 INFO - 'ts_paint', 19:39:52 INFO - 'tpaint', 19:39:52 INFO - 'sessionrestore', 19:39:52 INFO - 'sessionrestore_no_auto_restore', 19:39:52 INFO - 'tabpaint']}, 19:39:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['tsvgx', 19:39:52 INFO - 'tsvgr_opacity', 19:39:52 INFO - 'tart', 19:39:52 INFO - 'tscrollx', 19:39:52 INFO - 'cart']}, 19:39:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:39:52 INFO - 'tsvgr_opacity', 19:39:52 INFO - 'tart', 19:39:52 INFO - 'tscrollx', 19:39:52 INFO - 'cart']}, 19:39:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'talos_options': ['--disable-e10s'], 19:39:52 INFO - 'tests': ['tp5o']}, 19:39:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'tests': ['tp5o']}, 19:39:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'talos_options': ['--disable-e10s', 19:39:52 INFO - '--xperf_path', 19:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:52 INFO - 'tests': ['tp5n']}, 19:39:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:52 INFO - 'talos_options': ['--xperf_path', 19:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:52 INFO - 'tests': ['tp5n']}}, 19:39:52 INFO - 'talos.zip': {'path': '', 19:39:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:39:52 INFO - Running post-action listener: _resource_record_post_action 19:39:52 INFO - [mozharness: 2016-08-31 02:39:52.715678Z] Finished populate-webroot step (success) 19:39:52 INFO - [mozharness: 2016-08-31 02:39:52.715768Z] Running create-virtualenv step. 19:39:52 INFO - Running pre-action listener: _resource_record_pre_action 19:39:52 INFO - Running main action method: create_virtualenv 19:39:52 INFO - Creating virtualenv /builds/slave/test/build/venv 19:39:52 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 19:39:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:39:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:39:52 INFO - Using real prefix '/usr' 19:39:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:39:53 INFO - Installing distribute.............................................................................................................................................................................................done. 19:39:56 INFO - Installing pip.................done. 19:39:56 INFO - Return code: 0 19:39:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:39:56 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')]} 19:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:56 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')]} 19:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:56 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:39:56 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 19:39:56 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 19:39:56 INFO - Using env: {'DISPLAY': ':0', 19:39:56 INFO - 'HOME': '/home/cltbld', 19:39:56 INFO - 'LANG': 'en_US.UTF-8', 19:39:56 INFO - 'LANGUAGE': 'en_US:en', 19:39:56 INFO - 'LOGNAME': 'cltbld', 19:39:56 INFO - 'MAIL': '/var/mail/cltbld', 19:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:56 INFO - 'MOZ_NO_REMOTE': '1', 19:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:56 INFO - 'NO_EM_RESTART': '1', 19:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:56 INFO - 'PWD': '/builds/slave/test', 19:39:56 INFO - 'SHELL': '/bin/bash', 19:39:56 INFO - 'SHLVL': '1', 19:39:56 INFO - 'TERM': 'linux', 19:39:56 INFO - 'TMOUT': '86400', 19:39:56 INFO - 'USER': 'cltbld', 19:39:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:56 INFO - '_': '/tools/buildbot/bin/python'} 19:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:57 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 19:39:57 INFO - Cleaning up... 19:39:57 INFO - Return code: 0 19:39:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:39: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')]} 19:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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')]} 19:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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', '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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:39: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 psutil>=3.1.1 19:39:57 INFO - Using env: {'DISPLAY': ':0', 19:39:57 INFO - 'HOME': '/home/cltbld', 19:39:57 INFO - 'LANG': 'en_US.UTF-8', 19:39:57 INFO - 'LANGUAGE': 'en_US:en', 19:39:57 INFO - 'LOGNAME': 'cltbld', 19:39:57 INFO - 'MAIL': '/var/mail/cltbld', 19:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:57 INFO - 'MOZ_NO_REMOTE': '1', 19:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:57 INFO - 'NO_EM_RESTART': '1', 19:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:57 INFO - 'PWD': '/builds/slave/test', 19:39:57 INFO - 'SHELL': '/bin/bash', 19:39:57 INFO - 'SHLVL': '1', 19:39:57 INFO - 'TERM': 'linux', 19:39:57 INFO - 'TMOUT': '86400', 19:39:57 INFO - 'USER': 'cltbld', 19:39:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:57 INFO - '_': '/tools/buildbot/bin/python'} 19:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:57 INFO - Downloading/unpacking psutil>=3.1.1 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:39:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:39:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:39:59 INFO - Installing collected packages: psutil 19:39:59 INFO - Running setup.py install for psutil 19:39:59 INFO - building 'psutil._psutil_linux' extension 19:39:59 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 19:40:01 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 19:40:01 INFO - building 'psutil._psutil_posix' extension 19:40:01 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 19:40:01 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 19:40:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:01 INFO - Successfully installed psutil 19:40:01 INFO - Cleaning up... 19:40:01 INFO - Return code: 0 19:40:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:01 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:01 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 19:40:01 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 19:40:01 INFO - Using env: {'DISPLAY': ':0', 19:40:01 INFO - 'HOME': '/home/cltbld', 19:40:01 INFO - 'LANG': 'en_US.UTF-8', 19:40:01 INFO - 'LANGUAGE': 'en_US:en', 19:40:01 INFO - 'LOGNAME': 'cltbld', 19:40:01 INFO - 'MAIL': '/var/mail/cltbld', 19:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:01 INFO - 'MOZ_NO_REMOTE': '1', 19:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:01 INFO - 'NO_EM_RESTART': '1', 19:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:01 INFO - 'PWD': '/builds/slave/test', 19:40:01 INFO - 'SHELL': '/bin/bash', 19:40:01 INFO - 'SHLVL': '1', 19:40:01 INFO - 'TERM': 'linux', 19:40:01 INFO - 'TMOUT': '86400', 19:40:01 INFO - 'USER': 'cltbld', 19:40:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:01 INFO - '_': '/tools/buildbot/bin/python'} 19:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:40:03 INFO - Installing collected packages: mozsystemmonitor 19:40:03 INFO - Running setup.py install for mozsystemmonitor 19:40:04 INFO - Successfully installed mozsystemmonitor 19:40:04 INFO - Cleaning up... 19:40:04 INFO - Return code: 0 19:40:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:04 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:04 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 19:40:04 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 19:40:04 INFO - Using env: {'DISPLAY': ':0', 19:40:04 INFO - 'HOME': '/home/cltbld', 19:40:04 INFO - 'LANG': 'en_US.UTF-8', 19:40:04 INFO - 'LANGUAGE': 'en_US:en', 19:40:04 INFO - 'LOGNAME': 'cltbld', 19:40:04 INFO - 'MAIL': '/var/mail/cltbld', 19:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:04 INFO - 'MOZ_NO_REMOTE': '1', 19:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:04 INFO - 'NO_EM_RESTART': '1', 19:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:04 INFO - 'PWD': '/builds/slave/test', 19:40:04 INFO - 'SHELL': '/bin/bash', 19:40:04 INFO - 'SHLVL': '1', 19:40:04 INFO - 'TERM': 'linux', 19:40:04 INFO - 'TMOUT': '86400', 19:40:04 INFO - 'USER': 'cltbld', 19:40:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:04 INFO - '_': '/tools/buildbot/bin/python'} 19:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:04 INFO - Downloading/unpacking jsonschema==2.5.1 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:40:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:06 INFO - Downloading functools32-3.2.3-2.tar.gz 19:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:40:06 INFO - warning: no files found matching '*.txt' 19:40:06 INFO - no previously-included directories found matching 'build' 19:40:06 INFO - no previously-included directories found matching 'dist' 19:40:06 INFO - no previously-included directories found matching '.git*' 19:40:06 INFO - Installing collected packages: jsonschema, functools32 19:40:06 INFO - Running setup.py install for functools32 19:40:06 INFO - warning: no files found matching '*.txt' 19:40:06 INFO - no previously-included directories found matching 'build' 19:40:06 INFO - no previously-included directories found matching 'dist' 19:40:06 INFO - no previously-included directories found matching '.git*' 19:40:06 INFO - Successfully installed jsonschema functools32 19:40:06 INFO - Cleaning up... 19:40:06 INFO - Return code: 0 19:40:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:40:06 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')]} 19:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:06 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')]} 19:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:06 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:06 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 19:40:06 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 19:40:06 INFO - Using env: {'DISPLAY': ':0', 19:40:06 INFO - 'HOME': '/home/cltbld', 19:40:06 INFO - 'LANG': 'en_US.UTF-8', 19:40:06 INFO - 'LANGUAGE': 'en_US:en', 19:40:06 INFO - 'LOGNAME': 'cltbld', 19:40:06 INFO - 'MAIL': '/var/mail/cltbld', 19:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:06 INFO - 'MOZ_NO_REMOTE': '1', 19:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:06 INFO - 'NO_EM_RESTART': '1', 19:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:06 INFO - 'PWD': '/builds/slave/test', 19:40:06 INFO - 'SHELL': '/bin/bash', 19:40:06 INFO - 'SHLVL': '1', 19:40:06 INFO - 'TERM': 'linux', 19:40:06 INFO - 'TMOUT': '86400', 19:40:06 INFO - 'USER': 'cltbld', 19:40:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:06 INFO - '_': '/tools/buildbot/bin/python'} 19:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:40:06 INFO - Cleaning up... 19:40:06 INFO - Return code: 0 19:40:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:40:06 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')]} 19:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:06 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')]} 19:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:06 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:06 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 19:40:06 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 19:40:06 INFO - Using env: {'DISPLAY': ':0', 19:40:06 INFO - 'HOME': '/home/cltbld', 19:40:06 INFO - 'LANG': 'en_US.UTF-8', 19:40:06 INFO - 'LANGUAGE': 'en_US:en', 19:40:06 INFO - 'LOGNAME': 'cltbld', 19:40:06 INFO - 'MAIL': '/var/mail/cltbld', 19:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:06 INFO - 'MOZ_NO_REMOTE': '1', 19:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:06 INFO - 'NO_EM_RESTART': '1', 19:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:06 INFO - 'PWD': '/builds/slave/test', 19:40:06 INFO - 'SHELL': '/bin/bash', 19:40:06 INFO - 'SHLVL': '1', 19:40:06 INFO - 'TERM': 'linux', 19:40:06 INFO - 'TMOUT': '86400', 19:40:06 INFO - 'USER': 'cltbld', 19:40:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:06 INFO - '_': '/tools/buildbot/bin/python'} 19:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:07 INFO - Downloading/unpacking blobuploader==1.2.4 19:40:07 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 19:40:07 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 19:40:07 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 19:40:07 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 19:40:07 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 19:40:07 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 19:40:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:40:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:40:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 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 19:40:09 INFO - Downloading docopt-0.6.1.tar.gz 19:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:40:09 INFO - Installing collected packages: blobuploader, requests, docopt 19:40:09 INFO - Running setup.py install for blobuploader 19:40:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:40:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:40:09 INFO - Running setup.py install for requests 19:40:10 INFO - Running setup.py install for docopt 19:40:10 INFO - Successfully installed blobuploader requests docopt 19:40:10 INFO - Cleaning up... 19:40:10 INFO - Return code: 0 19:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40: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')]} 19:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40: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')]} 19:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:10 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:10 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 19:40:10 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 19:40:10 INFO - Using env: {'DISPLAY': ':0', 19:40:10 INFO - 'HOME': '/home/cltbld', 19:40:10 INFO - 'LANG': 'en_US.UTF-8', 19:40:10 INFO - 'LANGUAGE': 'en_US:en', 19:40:10 INFO - 'LOGNAME': 'cltbld', 19:40:10 INFO - 'MAIL': '/var/mail/cltbld', 19:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:10 INFO - 'MOZ_NO_REMOTE': '1', 19:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:10 INFO - 'NO_EM_RESTART': '1', 19:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:10 INFO - 'PWD': '/builds/slave/test', 19:40:10 INFO - 'SHELL': '/bin/bash', 19:40:10 INFO - 'SHLVL': '1', 19:40:10 INFO - 'TERM': 'linux', 19:40:10 INFO - 'TMOUT': '86400', 19:40:10 INFO - 'USER': 'cltbld', 19:40:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:10 INFO - '_': '/tools/buildbot/bin/python'} 19:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:10 INFO - Running setup.py (path:/tmp/pip-SYASDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:10 INFO - Running setup.py (path:/tmp/pip-EuiNDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:10 INFO - Running setup.py (path:/tmp/pip-uZMarC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:10 INFO - Running setup.py (path:/tmp/pip-_60tFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:10 INFO - Running setup.py (path:/tmp/pip-MR1xrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:10 INFO - Running setup.py (path:/tmp/pip-5Z7DAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:11 INFO - Running setup.py (path:/tmp/pip-OMypmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:11 INFO - Running setup.py (path:/tmp/pip-kSYKGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:11 INFO - Running setup.py (path:/tmp/pip-DVfZnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:11 INFO - Running setup.py (path:/tmp/pip-crUp3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:11 INFO - Running setup.py (path:/tmp/pip-w6PsEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:11 INFO - Running setup.py (path:/tmp/pip-8S_MWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:11 INFO - Running setup.py (path:/tmp/pip-_dT2Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:11 INFO - Running setup.py (path:/tmp/pip-IjY_qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:11 INFO - Running setup.py (path:/tmp/pip-X6yehJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:11 INFO - Running setup.py (path:/tmp/pip-7_Rf7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:11 INFO - Running setup.py (path:/tmp/pip-jilkOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:40:11 INFO - Running setup.py install for manifestparser 19:40:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:40:11 INFO - Running setup.py install for mozcrash 19:40:12 INFO - Running setup.py install for mozdebug 19:40:12 INFO - Running setup.py install for mozdevice 19:40:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Running setup.py install for mozfile 19:40:12 INFO - Running setup.py install for mozhttpd 19:40:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Running setup.py install for mozinfo 19:40:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Running setup.py install for mozInstall 19:40:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Running setup.py install for mozleak 19:40:12 INFO - Running setup.py install for mozlog 19:40:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Running setup.py install for moznetwork 19:40:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:40:12 INFO - Running setup.py install for mozprocess 19:40:13 INFO - Running setup.py install for mozprofile 19:40:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:40:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:40:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:40:13 INFO - Running setup.py install for mozrunner 19:40:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:40:13 INFO - Running setup.py install for mozscreenshot 19:40:13 INFO - Running setup.py install for moztest 19:40:13 INFO - Running setup.py install for mozversion 19:40:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:40:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:40:13 INFO - Cleaning up... 19:40:13 INFO - Return code: 0 19:40:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:13 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')]} 19:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:13 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')]} 19:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:13 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:13 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 19:40:13 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 19:40:13 INFO - Using env: {'DISPLAY': ':0', 19:40:13 INFO - 'HOME': '/home/cltbld', 19:40:13 INFO - 'LANG': 'en_US.UTF-8', 19:40:13 INFO - 'LANGUAGE': 'en_US:en', 19:40:13 INFO - 'LOGNAME': 'cltbld', 19:40:13 INFO - 'MAIL': '/var/mail/cltbld', 19:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:13 INFO - 'MOZ_NO_REMOTE': '1', 19:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:13 INFO - 'NO_EM_RESTART': '1', 19:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:13 INFO - 'PWD': '/builds/slave/test', 19:40:13 INFO - 'SHELL': '/bin/bash', 19:40:13 INFO - 'SHLVL': '1', 19:40:13 INFO - 'TERM': 'linux', 19:40:13 INFO - 'TMOUT': '86400', 19:40:13 INFO - 'USER': 'cltbld', 19:40:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:13 INFO - '_': '/tools/buildbot/bin/python'} 19:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:13 INFO - Running setup.py (path:/tmp/pip-K101A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:13 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)) 19:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:13 INFO - Running setup.py (path:/tmp/pip-7DtscH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:13 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)) 19:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:13 INFO - Running setup.py (path:/tmp/pip-eV3XpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:14 INFO - Running setup.py (path:/tmp/pip-tGv8JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:14 INFO - Running setup.py (path:/tmp/pip-hKDBtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:14 INFO - Running setup.py (path:/tmp/pip-TZEgEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:14 INFO - Running setup.py (path:/tmp/pip-YxpPqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:14 INFO - Running setup.py (path:/tmp/pip-a_YYe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:14 INFO - Running setup.py (path:/tmp/pip-k6cTGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:14 INFO - Running setup.py (path:/tmp/pip-5Yvp1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:14 INFO - Running setup.py (path:/tmp/pip-B1x1au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:14 INFO - Running setup.py (path:/tmp/pip-bzPX3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:14 INFO - Running setup.py (path:/tmp/pip-40Pj__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:14 INFO - Running setup.py (path:/tmp/pip-wUVLic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:14 INFO - Running setup.py (path:/tmp/pip-UelwDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:14 INFO - Running setup.py (path:/tmp/pip-91_npH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40:14 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)) 19:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:14 INFO - Running setup.py (path:/tmp/pip-QCqNNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:15 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)) 19:40:15 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)) 19:40:15 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)) 19:40:15 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)) 19:40:15 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)) 19:40:15 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)) 19:40:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:40:15 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 19:40:15 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 19:40:15 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 19:40:15 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 19:40:15 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 19:40:15 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 19:40:16 INFO - Downloading blessings-1.6.tar.gz 19:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:40:17 INFO - Installing collected packages: blessings 19:40:17 INFO - Running setup.py install for blessings 19:40:17 INFO - Successfully installed blessings 19:40:17 INFO - Cleaning up... 19:40:17 INFO - Return code: 0 19:40:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:17 INFO - Reading from file tmpfile_stdout 19:40:17 INFO - Current package versions: 19:40:17 INFO - argparse == 1.2.1 19:40:17 INFO - blessings == 1.6 19:40:17 INFO - blobuploader == 1.2.4 19:40:17 INFO - docopt == 0.6.1 19:40:17 INFO - functools32 == 3.2.3-2 19:40:17 INFO - jsonschema == 2.5.1 19:40:17 INFO - manifestparser == 1.1 19:40:17 INFO - mozInstall == 1.12 19:40:17 INFO - mozcrash == 0.17 19:40:17 INFO - mozdebug == 0.1 19:40:17 INFO - mozdevice == 0.48 19:40:17 INFO - mozfile == 1.2 19:40:17 INFO - mozhttpd == 0.7 19:40:17 INFO - mozinfo == 0.9 19:40:17 INFO - mozleak == 0.1 19:40:17 INFO - mozlog == 3.3 19:40:17 INFO - moznetwork == 0.27 19:40:17 INFO - mozprocess == 0.23 19:40:17 INFO - mozprofile == 0.28 19:40:17 INFO - mozrunner == 6.12 19:40:17 INFO - mozscreenshot == 0.1 19:40:17 INFO - mozsystemmonitor == 0.3 19:40:17 INFO - moztest == 0.7 19:40:17 INFO - mozversion == 1.4 19:40:17 INFO - psutil == 3.1.1 19:40:17 INFO - requests == 1.2.3 19:40:17 INFO - wsgiref == 0.1.2 19:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:17 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')]} 19:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 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')]} 19:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:17 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 19:40:17 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 19:40:17 INFO - Using env: {'DISPLAY': ':0', 19:40:17 INFO - 'HOME': '/home/cltbld', 19:40:17 INFO - 'LANG': 'en_US.UTF-8', 19:40:17 INFO - 'LANGUAGE': 'en_US:en', 19:40:17 INFO - 'LOGNAME': 'cltbld', 19:40:17 INFO - 'MAIL': '/var/mail/cltbld', 19:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:17 INFO - 'MOZ_NO_REMOTE': '1', 19:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:17 INFO - 'NO_EM_RESTART': '1', 19:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:17 INFO - 'PWD': '/builds/slave/test', 19:40:17 INFO - 'SHELL': '/bin/bash', 19:40:17 INFO - 'SHLVL': '1', 19:40:17 INFO - 'TERM': 'linux', 19:40:17 INFO - 'TMOUT': '86400', 19:40:17 INFO - 'USER': 'cltbld', 19:40:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:17 INFO - '_': '/tools/buildbot/bin/python'} 19:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 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)) 19:40:17 INFO - Cleaning up... 19:40:17 INFO - Return code: 0 19:40:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:40:17 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')]} 19:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 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')]} 19:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 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 0x7f45ab896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', '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 19:40:17 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 19:40:17 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 19:40:17 INFO - Using env: {'DISPLAY': ':0', 19:40:17 INFO - 'HOME': '/home/cltbld', 19:40:17 INFO - 'LANG': 'en_US.UTF-8', 19:40:17 INFO - 'LANGUAGE': 'en_US:en', 19:40:17 INFO - 'LOGNAME': 'cltbld', 19:40:17 INFO - 'MAIL': '/var/mail/cltbld', 19:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:17 INFO - 'MOZ_NO_REMOTE': '1', 19:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:17 INFO - 'NO_EM_RESTART': '1', 19:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:17 INFO - 'PWD': '/builds/slave/test', 19:40:17 INFO - 'SHELL': '/bin/bash', 19:40:17 INFO - 'SHLVL': '1', 19:40:17 INFO - 'TERM': 'linux', 19:40:17 INFO - 'TMOUT': '86400', 19:40:17 INFO - 'USER': 'cltbld', 19:40:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:17 INFO - '_': '/tools/buildbot/bin/python'} 19:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:40:17 INFO - Cleaning up... 19:40:17 INFO - Return code: 0 19:40:17 INFO - Running post-action listener: _resource_record_post_action 19:40:17 INFO - Running post-action listener: _start_resource_monitoring 19:40:17 INFO - Starting resource monitoring. 19:40:17 INFO - [mozharness: 2016-08-31 02:40:17.925320Z] Finished create-virtualenv step (success) 19:40:17 INFO - [mozharness: 2016-08-31 02:40:17.926291Z] Running install step. 19:40:17 INFO - Running pre-action listener: _resource_record_pre_action 19:40:17 INFO - Running main action method: install 19:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:18 INFO - Reading from file tmpfile_stdout 19:40:18 INFO - Detecting whether we're running mozinstall >=1.0... 19:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:40:18 INFO - Reading from file tmpfile_stdout 19:40:18 INFO - Output received: 19:40:18 INFO - Usage: mozinstall [options] installer 19:40:18 INFO - Options: 19:40:18 INFO - -h, --help show this help message and exit 19:40:18 INFO - -d DEST, --destination=DEST 19:40:18 INFO - Directory to install application into. [default: 19:40:18 INFO - "/builds/slave/test"] 19:40:18 INFO - --app=APP Application being installed. [default: firefox] 19:40:18 INFO - mkdir: /builds/slave/test/build/application 19:40:18 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'] 19:40:18 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 19:40:34 INFO - Reading from file tmpfile_stdout 19:40:34 INFO - Output received: 19:40:34 INFO - /builds/slave/test/build/application/firefox/firefox 19:40:34 INFO - Running post-action listener: _resource_record_post_action 19:40:34 INFO - [mozharness: 2016-08-31 02:40:34.340321Z] Finished install step (success) 19:40:34 INFO - [mozharness: 2016-08-31 02:40:34.340606Z] Running run-tests step. 19:40:34 INFO - Running pre-action listener: _resource_record_pre_action 19:40:34 INFO - Running main action method: run_tests 19:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:40:34 INFO - Python 2.7.3 19:40:34 INFO - Return code: 0 19:40:34 INFO - grabbing minidump binary from tooltool 19:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:34 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 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:40:34 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 19:40:34 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 19:40:34 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 19:40:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:40:34 INFO - Return code: 0 19:40:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:40:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:40:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:40:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:40:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:40:34 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/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 19:40:34 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/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 19:40:34 INFO - Using env: {'DISPLAY': ':0', 19:40:34 INFO - 'HOME': '/home/cltbld', 19:40:34 INFO - 'LANG': 'en_US.UTF-8', 19:40:34 INFO - 'LANGUAGE': 'en_US:en', 19:40:34 INFO - 'LOGNAME': 'cltbld', 19:40:34 INFO - 'MAIL': '/var/mail/cltbld', 19:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:34 INFO - 'MOZ_NO_REMOTE': '1', 19:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:34 INFO - 'NO_EM_RESTART': '1', 19:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:34 INFO - 'PWD': '/builds/slave/test', 19:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:40:34 INFO - 'SHELL': '/bin/bash', 19:40:34 INFO - 'SHLVL': '1', 19:40:34 INFO - 'TERM': 'linux', 19:40:34 INFO - 'TMOUT': '86400', 19:40:34 INFO - 'USER': 'cltbld', 19:40:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789', 19:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:34 INFO - '_': '/tools/buildbot/bin/python'} 19:40:34 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/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 19:40:34 INFO - mozversion application_buildid: 20160830181721 19:40:34 INFO - mozversion application_changeset: 506facea63169a29e04eb140663da1730052db64 19:40:34 INFO - mozversion application_display_name: Nightly 19:40:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:40:34 INFO - mozversion application_name: Firefox 19:40:34 INFO - mozversion application_remotingname: firefox 19:40:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:40:34 INFO - mozversion application_vendor: Mozilla 19:40:34 INFO - mozversion application_version: 51.0a1 19:40:34 INFO - mozversion platform_buildid: 20160830181721 19:40:34 INFO - mozversion platform_changeset: 506facea63169a29e04eb140663da1730052db64 19:40:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:40:34 INFO - mozversion platform_version: 51.0a1 19:40:34 INFO - using testdate: 1472611234 19:40:34 INFO - actual date: 1472611234 19:40:34 INFO - starting webserver on 'localhost:52470' 19:40:34 INFO - SUITE-START | Running 2 tests 19:40:34 INFO - TEST-START | dromaeo_css 19:40:34 INFO - operating with platform_type : linux_ 19:40:34 INFO - Initialising browser for dromaeo_css test... 19:40:34 INFO - TEST-INFO | started process 3299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwzBTp/profile http://localhost:52470/getInfo.html) 19:40:44 INFO - PROCESS | 3299 | __metrics Screen width/height:1600/1200 19:40:44 INFO - PROCESS | 3299 | colorDepth:24 19:40:44 INFO - PROCESS | 3299 | Browser inner width/height: 1024/697 19:40:44 INFO - PROCESS | 3299 | __metrics 19:40:45 INFO - PROCESS | 3299 | 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" 19:40:45 INFO - PROCESS | 3299 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:40:46 INFO - PROCESS | 3299 | console.error: PushService: 19:40:46 INFO - PROCESS | 3299 | stateChangeProcessEnqueue: Error transitioning state 19:40:46 INFO - PROCESS | 3299 | UnknownError 19:40:46 INFO - TEST-INFO | 3299: exit 0 19:40:46 INFO - Browser initialized. 19:40:46 INFO - Running cycle 1/1 for dromaeo_css test... 19:40:46 INFO - TEST-INFO | started process 3381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwzBTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:59 INFO - PROCESS | 3381 | RSS: Main: 182099968 19:40:59 INFO - PROCESS | 3381 | 19:41:51 INFO - PROCESS | 3381 | 1472611311015 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] 19:44:03 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:52470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52470/tests/dromaeo/cssquery-ext.html) 19:44:04 INFO - PROCESS | 3381 | RSS: Main: 271122432 19:44:04 INFO - PROCESS | 3381 | 19:47:07 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:52470/tests/dromaeo/cssquery-ext.html (next: http://localhost:52470/tests/dromaeo/cssquery-jquery.html) 19:47:08 INFO - PROCESS | 3381 | RSS: Main: 272302080 19:47:08 INFO - PROCESS | 3381 | 19:50:10 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:52470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52470/tests/dromaeo/cssquery-mootools.html) 19:50:10 INFO - PROCESS | 3381 | RSS: Main: 257527808 19:50:10 INFO - PROCESS | 3381 | 19:53:13 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:52470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52470/tests/dromaeo/cssquery-prototype.html) 19:53:13 INFO - PROCESS | 3381 | RSS: Main: 249155584 19:53:13 INFO - PROCESS | 3381 | 19:56:17 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:52470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52470/tests/dromaeo/cssquery-yui.html) 19:56:17 INFO - PROCESS | 3381 | RSS: Main: 216887296 19:56:17 INFO - PROCESS | 3381 | 19:59:20 INFO - PROCESS | 3381 | Cycle 1(1): loaded http://localhost:52470/tests/dromaeo/cssquery-yui.html (next: http://localhost:52470/tests/dromaeo/cssquery-dojo.html) 19:59:21 INFO - PROCESS | 3381 | RSS: Main: 309030912 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | __start_tp_report 19:59:21 INFO - PROCESS | 3381 | _x_x_mozilla_page_load 19:59:21 INFO - PROCESS | 3381 | _x_x_mozilla_page_load_details 19:59:21 INFO - PROCESS | 3381 | |i|pagename|runs| 19:59:21 INFO - PROCESS | 3381 | |0;dojo.html;2596.5070084701297;2602.4144567472317;2603.8437693738365;2644.2463897789135;2663.7602615764577;4523.231050721377;4594.862154135381;4601.03378290559;4678.251479763234;4740.3600513930605;4621.607163391116;4629.606483448911;4666.34671146039;4676.181668208059;4687.250039993602;4230.9153816923645;4233.978830105861;4301.935470967938;4367.847125350613;4451.933221001671;4353.804078816445;4384.9561504384865;4395.626371758404;4417.403650507173;4430.9778451107695;4239.215745087169;4266.679999000087;4288.24955632763;4294.420253265832;4334.653227741773;4222.451081359403;4322.913541729148;4323.200207961506;4325.978370108161;4374.496932852699;4263.4883813942215;4270.572942705736;4274.786260686953;4305.655547556188;4376.321670141133;4642.1876171670165;4704.788284527204;4708.74101924394;4720.929186062178;4768.403949506312;4898.583620392235;4931.50684931504;4947.529984651453;4967.602591792648;5026.84919452417;4966.602671786284;4969.229769385751;4982.427020892571;4992;5059.848204553832;4679.134360143316;4684.578387945033;4686.297055441677;4688.062387522441;4691.413573303337;4932.55606995365;5082.898342033139;5121.027004869063;5137.5889928806355;5216.817411390583;4911.214205727067;4911.901761964741;4938.753062346868;4940.481249468754;4961.900761984813;4980.975095124501;4982.750862456863;4987.975060124749;4990.101781679333;4997.0505603935135;4770.284457331359;4849.151398505318;4887.657863949489;4913.533214344631;4944.431390390151;4904.8773780655765;4905.583025442806;4906.165951788204;4908.165611845995;4964.90070198594;4161.812718427678;4169.937450938239;4177.791110444527;4184.351425529047;4231.005713657288;3589.1565482111682;3618.7466877318334;3649.671529562352;3665.991852240655;3673;4243.575642435793;4258.488981322261;4273.551277115858;4311.611954924072;4315.09383029561;4956.950430495721;4963.354763880672;4971.254311853251;4972.279019542146;5027.899442011212;4174.7077704561;4208.494980602286;4251.426057482262;4252.277112890816;4259.595338442843;4480.507144214133;4507.5943165115295;4532.909341813145;4558.726476411426;4564.8402305919135;4699.389079419722;4702.553257440538;4735.59747421473;4743.146233677971;4798.016406636701;4828.830990915301;4860.562549370432;4968.205087186033;5037.848864534069;5048.318477005704;4686.531346865286;4693.155232058262;4705.623550115914;4762.571368576845;4775.689580177416;4944.975275123601;4948.554630083309;4956.752162391938;4964.751762411937;4990.326305948795;4837.733924634179;4910.631702622246;5002.424721156968;5013.724245166551;5071.644984851025;4819.060283244734;4857;4865.294532292727;4870.342503761947;4910.779014944264;4854.053459575349;4856.295837103529;4857.465678775403;4859.2954021667365;4902.485239049848;4691.671582989158;4773.641976851681;4790.281457781361;4808.951910480991;4855.344528488608;4826.638002149783;4849.733264670336;4893.314935908905;4983.8504844854715;4993.600511958962;4779.450363208137;4781.115493633689;4798.280257961194;4828.444728856086;4852.8301509447 19:59:21 INFO - PROCESS | 3381 | |1;ext.html;566.7449647658553;574.718387989885;577.3129975329358;587.4125874125874;609.9481544068753;33435;36940;37005.81497092511;37026;37050.44424333634;37401;37855;37917.62082379175;37919;37934.051648708795;7174.098863801097;7344.48588598797;7488.063992001;7491.400687944952;9609.711708648716;9465.810683786354;9813.264005199602;9831.31180817343;9831.705048848546;9834.803303933917;9875.901240987607;9919.768052188272;9927.751806204831;9932.35439696421;9934.30459867806;9820.705378838646;9846.9507652462;9865.062819032217;9869.161121304698;9872.012798720143;9664.226861851035;9719.271054670928;9725.319227654067;9730.978247284003;9736.172425343855;36746.265074698626;37070.81464592687;37144.44283335752;37147.442788358196;37186.628133718856;2642.9074982375523;2844.459552684983;2985.880564777406;3062.6018617579793;3173.9206519836957;28067.43865122686;28527.57208641872;28545.57181642277;28612.570811437847;28621.856890715415;3097.117321563366;3142.292984078587;3213.1485156433564;3310.337932413527;3323.7008669219886;252050;253826;254065;254720.72639636867;255362;30590;31199.376012479624;48103;48685.756571216916;48694.75652621714;32512.187195320304;32675;32715;32741.181470462954;32780.67219327824;12657.531781302558;12787.232766034067;12790.680232994064;12870.549530766379;12874.61376158698;8775.254103401156;9490.952545237229;9788.657396991071;9838.3113182078;10233.641822536176;7666.65500052499;7704.614769261514;7749.147593764681;7749.961250193713;7761.223877612194;3047.2991212020916;3070.9846450767604;3083.676213997498;3102.069379186235;3103.7672174586996;748.3788455581854;822.8151461894852;860.7934095817084;921.4609453469661;927.5130556457914;25173.748262517507;26813.86593067061;27009;27052.188434347;29577.408451830845;870.9912900871037;887.4852585500523;921.9308551858637;943.0522325063267;965.8696076029646;13667.589972300846;14660.266986650624;14688.706225875423;14743.010597038132;14805.111693298437;394565;398988;399323;399459;399724;46955;47286.763566182635;47349.76325118421;47506.52493475021;47510.287345689845;1007.9546420411099;1080.7082087836397;1107.8061339265596;1153.6942710181977;1174.1663418972455;24670.629940551265;27794.722052779212;28130.71869281281;28668.856655717424;29078.563821543117;39660;40182.79908600439;40210.597894020684;40211;40230.39654405245;247164;248415;248544;248667;248793;24200.75799241985;25418;25481;26404.20787376382;26496.735032649427;40737;40987.59012409838;41114;41823.58176418197;41955.58044419639;34883.65116348804;35101;35106;35358.646413535535;35595;33109.83445082759;33479.49780753339;33812.66187338095;34011.14972125716;34084.31831363408;34522.48216276808;35139.47290790589;35231.295374092886;35572;35879.64120358763;29996.550051748804;32090.518642220854;32207;32269.35461290808;32571.837140814143;24472.265832025067;24872.058339401956;24895.87552062228;24936.625950610392;25317.87341063283 19:59:21 INFO - PROCESS | 3381 | |2;jquery.html;342.9082596163405;365.87560229521966;368.25796021017635;370.50352527612995;386.5438782236959;12167.08746843987;15836.524904252876;16137.354505819767;16275.674486510263;17293.04888231147;15919.602009949756;16135.354585816553;16170.83829161708;16921;17044.744328835077;5064.316317297164;5121.385433747955;5277.287566178555;5334.306540149775;5375.543078838284;3404.114930118175;5137.280780690707;5379.408265090857;5421.051316019701;5421.430749771276;5346.091164502024;5453.345598528163;5466.562674986011;5477.972610136963;5483;5254.238135470336;5393.622446428752;5424.376196737347;5448.91826622601;5454.53636440901;5254.605904557174;5255.842324730264;5256.21288761819;5261.500157485033;5262.526372626444;10254.333468324536;13844.861551384458;20244.392668219978;20391.898040509703;20415.897920510302;1588.6822635472836;1683.7895263092114;1730.3165249726414;1731.3420900058022;1762.3831658919403;8480.533570653673;8596.398252122353;8714.825703485958;8743.387962842604;8956.104389561056;1556.766485027255;1680.3530640703295;1685.7104315198883;1709.2564734340601;1719.9570010749705;64714;65916.3408365915;67603;71980.28019719788;73229;9318.534073296309;9410.153086222273;9836.360636558744;10147.904889008923;10481.842772358421;13941.790873136912;13944.58166255014;13948.86051139496;13976.091554048955;13984.650383740487;6747;6944.062551555577;6951.7219311228;7158.749443769547;7175.210726820045;6471.320511346241;6472.482201423874;6619.106420633153;6636.435902948207;6672.332766723386;4315.136972605429;4319.503257125408;4377.124575084932;4522.23122069249;4532.252178390595;1561.73450513413;1673.380849085846;1814.609858880347;1861.9092306770697;1862.9254829806928;721.6463932673057;795.3994733975811;822.4078663362369;829.7344849648175;840.5923127283263;15859.920700396424;16252.918735406483;16348.427805027004;16564.75152872708;17350.56623584395;795.908470525897;815.7226542975417;818.9385796065319;820.5281962871372;849.6049337058174;9085.364024518352;9263.212626926652;9400.90599094014;9548.61805527785;9621.663241786504;355987;365973;366422;367271;367366;73391.63304183444;73910.63044684743;74520.25479745242;76884.23115768771;79821;859.4070091636751;860;898.5552151684827;919.2783664823082;920.204023519664;14808.520847286572;15086;15790.921045395158;15936.442224522087;16253.837461625233;38469.807650961564;38720;39188.804055980676;39357.606423935395;40033;51730;53441.46558534365;54008;54465.830125481494;55030.72484637711;4637.582617564435;4728.621710263102;7167.749128780468;7362.239160314882;7541.698332066875;11482.987523024805;11746.765064698488;12136.150469467053;12202.32887191213;12236.449359778653;7537.170911199654;8177.918220817715;9796.559154838193;9869.555869986012;10792.838107428237;10445.738856528647;10514.57941682324;10583.417912014913;10596.682099537025;10639.734006649896;10504.579816807547;10561.26071175041;10624.450131968426;10686;10782.514786834454;6252.531060170414;6962.094927659372;7490.4007679386605;7764.61176941162;7773.37812974972;9514.333996620448;10611.681649550526;10717.142628589538;10814.621488247874;11077.778444431227 19:59:21 INFO - PROCESS | 3381 | |3;mootools.html;1343.570057581574;1366.1461586508433;1413.922234277115;1617.724986752252;1673.0965278749477;6975.895361569575;7506.2869027442375;7508.587027713474;7515.060617422822;7524.097108346999;6351.142595749572;6988.126484189476;7175.82060448489;7215.747448839292;7408.518446300986;2123.3948324727417;2150.2689085710854;2151.7310336207975;2154.235246487498;2167.501474660829;2120.34269376493;2147.5812216617765;2176.564687062586;2187.8030977212047;2192.8684278943315;2123.3948324727457;2124.2140408049045;2124.7768984256663;2128.755193152784;2149.5271040371094;2079;2079.116375540389;2083.312506872728;2088.33173384517;2088.624047671426;2057.2285392977633;2115.925942592002;2117.76704562498;2126.011404696808;2127.0322003488377;7437.51656142349;7534.397248220129;7538.434617403662;7541.849163016764;7561.697532098709;4278.4010238566625;4413.249747542925;4414.337849322627;4414.470263568361;4420.6242469390145;2696.4472283182095;2755.5453350197195;2834.1214223590546;2846.8434236117005;2860.5280128778727;891.1940854514685;931.1386967055447;937.8546325319518;940.6378544260509;951.8001219743862;9874.9506252469;9907.851382229272;9922.156616687591;9933.850992235122;9960.750981225456;3740.0462881964927;3849.538055433366;3932.4297976793205;3986.80065996699;4020.336644453691;8593.22660960504;8603.483790972561;8606.741797746077;8607.18231767981;8626.827463450696;4286.54991225923;4289.056407590325;4290.785460726951;4293.871183864427;4346.869593912188;3583.1221350768706;3829.215010922754;3924.4113382992778;3947.3092208863336;3961.6830653547645;3456.948145777815;3534.699550538233;3568.2167909030995;3601.9099522511624;3610.368185567515;1131.0894729742472;1131.4625552862324;1143.1712008793725;1145.633397312852;1150.5685367987005;605.6275390634728;623.0654018971543;663.5322097920954;726.9531874101277;740.2301606329464;4588.26587745959;4666.416697912761;4841.443234028062;4919.926201106986;5078.67954331869;386.5110635046668;388.4891367851267;388.6715725212191;389.11670507946803;395.5787086752599;3238.611366636019;3374.291398806229;3378.577677790276;3385.8318879986364;3430.6054803697393;8500.65997360111;8750.82498350042;8898.59956301968;8956;9013.774655633662;8852.159044890725;8852.911470885338;8857.424267422597;8859.822803544022;8860.202581767671;6594.934050659528;6656.101426307387;6691.899621505681;6713.362230588086;6716.697748601325;4759.833405830779;4823.445303790109;4875.219964805614;4877.365942427462;4963.975180124076;8326.084130745734;8347.457415267989;8359.373047021376;8364.53995030255;8398.958005209935;8097.757067287991;8388.58057097155;8400.663973440995;8442.493450392996;8654.567271636519;5739.799107031234;5909.3795151508475;5916.763329466773;6155.630662160284;6334.936650633619;6409.391107844747;6450.387213214737;6643.56816806906;6655.73377064912;6842.315768423118;5981.820545383645;6192.018554062657;6238.968805155945;6273.96863015682;6319.715612797527;6240.719167637377;6275.717592708431;6284.780032698834;6309.337519560564;6371;5750.769969201185;5835.708214589338;5845.064789633639;5854.414558544111;5870.354261031369;4264.147170565837;4285.985586774211;4305.117450922616;4343;4482.484514280899;4243.405923170821;4297.720648157985;4329.19909816685;4432.911341773211;4535.455745310584 19:59:21 INFO - PROCESS | 3381 | |4;prototype.html;262.8593702369232;267.46907388833176;269.1682700455592;275.6017554633555;278.4056040353844;4767.90464190716;4819.445763737172;4826.396700412449;4836.830710925118;4839.225723884179;4474.888127796807;4576.771161441931;4729.858104256878;4731.290306454025;4771.737554434505;3761.0973366392004;3761.661450469457;3768.1536047336745;3772.4907137536493;3774.924501509968;3770.4909837171904;3770.660640542351;3777.527809023872;3779.848806047755;3781.1870447853707;3547.840347184383;3581.158427769472;3706.8517259309597;3736.140687641844;3758.7932663703486;3718.553773547178;3719.107414220595;3723.0506220913494;3726.5900750917376;3737.402015677506;3230.4318067136683;3265.746634821989;3272.312814308998;3284.211789170582;3290.9506357404657;4391.407160033418;4613.953860461386;4651.86044418668;4664.976675116636;4672.112298663277;4175.54069052404;4198.076423186894;4198.6011328923705;4210.179015092058;4214.7681877496725;4992.276119962621;5009.670503216022;5027.84916452507;5044.117279476077;5044.672096313728;3501.072215862798;3501.6323286054853;3516.2594515714886;3516.7186625069935;3520.366334059868;4972.850814475535;5224.294720212799;5243.2659427680155;5244.370675518924;5254.369475662945;3539.309834582283;3551.147724546142;3551.982240088783;3590.317839610466;3600.5499312585926;3599.6220396858475;3640.2537479816574;3640.3993341098953;3642.8724994625063;3650.5619325681087;3957.3668213086344;4204.579542045771;4214.524916279278;4215.093754842724;4216.9578304217175;5012.396033269391;5020.5732512736095;5034.194528875362;5044.940562481846;5050.72221027847;1172.5661505242945;1237.7957636989795;1250.6560695808544;1252.5303011370736;1255.234307072685;813.7802793245909;845.9974929708316;848.762346542969;855.781775647206;857.0572370392518;4387.188370151533;4391.5388884166705;4395.384646149541;4407.823687052482;4424.269995450714;5111.846644600668;5125.15434953236;5125.461826508237;5137.640365174402;5147.2279158126585;4223.345381465878;4389.58572784967;4396.60430561251;4477.910441791211;4502.57225563571;2765.3363192833576;2781.1378472673537;2794.2036519592225;2794.421152049086;2799.0483235699553;4944.566075838039;4949.406071271471;4953.72754498506;4962.627802914796;4964.90070198594;5116.820911268088;5274.815381461631;5293.200311893975;5311.229871668664;5345.438728933484;4894.657373983858;4904.901901961941;4918.311436398907;4924.4090709115135;4934.4572097069295;5182.844514664566;5225.268462415341;5232.869178270574;5235.502627250406;5236.45017273196;4996.925046124238;5033.546980771748;5056.457780376873;5065.797368105382;5107.41264754558;4839.370881785346;4845.103655823684;4878.8045379578625;4882.90234195307;4899.289603007615;3585.515955345995;3585.8924232273075;3586.7847929124337;3596.5504311961004;3600.117971097098;4963.205887058053;5134.845954621367;5178.792848286026;5181.1969144782615;5184.637075404686;4959.107360675113;4990.750462476934;5002.52476014778;5021.271915572294;5025.547700706954;4993.15116430215;5028.723420211923;5035.244713293036;5048.737815546114;5057.797688092435;4757.5718185363485;4808.807647694193;4954.3311652926395;4955.456848353445;5006.123928312603;4937.975310123426;5074.340335756328;5133.486651334837;5135.666181698178;5140.691558506502;4968;4993.300937868628;4993.875153121201;4998.925016124834;5016.2224855147515 19:59:21 INFO - PROCESS | 3381 | |5;yui.html;537.1244870860497;584.2972587545555;613.1262950295827;614.709110867179;659.423004870738;13317.733645327087;14543.127412355267;14584.489542865975;14614.634634134125;14693.33879975401;12969.22184668918;13796.241206733626;13883.930580347109;13888.23614701191;13928.1643101414;725.5719125715826;749.1983577572;752.5672738175543;752.8682480565907;754.2118486181926;612.2622240200548;728.7340120855876;750.9586972716498;753.3220101908272;756.6784116750387;801.3629164813958;802.9478083924555;803.9035315762087;804.1034246814818;804.1315379390273;794.8887155798193;794.9125596184415;795.4153697032676;795.49883573349;795.6538905576093;469.9953000469986;555.822136916187;569.3651578489995;569.5785119011942;582.7581553655228;12955.417006234742;13409.798853017213;13418.26199559024;13422.261775602337;13429.194248345131;11291.830622540669;11709.455228553532;11929.224600400947;12104.394780260951;12725.490980360775;11569.479373428216;11610;11677.124215683858;11717.824232636518;11745.530178792924;4143.295639741251;4162.271602469556;4191.455110835603;4234.618884300427;4266.679999000087;65677.67161164212;66548.66725666341;70591.2940870595;70636;71957.64021179912;9263.675771347971;9510.1440870322;9800.313978021613;9931.900680993242;9942.453165075991;19674;20021.69642009052;20030.599388012157;20058.197672092952;20065.498362541053;6620.172478440195;6729.629870357177;6749.831254218684;6751.324867513307;7022.192447868459;3816.885493435201;3928.9017774555864;3944.2308749793515;3999.900002499961;4000.8199631016673;2887.191586355824;2999.580058791771;2999.820010799359;3010.142109498826;3018.9245268868453;467.8900458392275;468.7632745463519;479.24040395972776;494.1056687395825;499.6752111127796;399.9680025598003;473.0869422015543;476.11680332982513;483.32817383836493;505.5323825461507;7017.228104908456;7228.132624085143;7353.154387245429;7586.203448637813;7706.38348932084;394.19387352863464;406.1673569183163;409.41453721179;425.5404163503409;450.9537872136677;3376.392249395083;3497.877574284939;3577.678008979204;3642.0894776305922;3681.5766186888313;102704;103842.48078759557;104133;105763;107198;92228.53885730663;92409;92664.53667731618;93189.5340523293;94228;47083;60936.69531652313;75382.62308688641;76373.6181319101;76716;6933.653317334012;7260.382867456114;7279.490435669452;7304.5252058616015;7344.4332240590065;33010.66989330076;33075.66924330726;42487.57512424836;47364.60025778685;48565.75717121392;36929;55023.72488137534;66823;67888;68082.19178082152;8191.877121843297;8402.915970840213;8484.499090520727;8658.653653854028;8838.911610884066;9833.5083245836;9863.506824658594;9969.850452243078;10692;10714.624988125379;9257.629694812133;9530.094641009093;9675.758106047406;10057.094861462503;10069.546870390703;9253;9391.671291504765;9425.340226184102;9690.95154524223;9787.657431989846;8224;8554.101819309131;8613.397062205586;8674.132586741276;8719.389642725202;6465;6673.733050677918;6936.549124306904;6959;7425.8143546411775;7545.849083018418;7602.239776022575;7761.495502792301;7776.339011184113;7884.369250459835 19:59:21 INFO - PROCESS | 3381 | __end_tp_report 19:59:21 INFO - PROCESS | 3381 | __start_cc_report 19:59:21 INFO - PROCESS | 3381 | _x_x_mozilla_cycle_collect,998 19:59:21 INFO - PROCESS | 3381 | __end_cc_report 19:59:21 INFO - PROCESS | 3381 | __startTimestamp1472612361068__endTimestamp 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | ------- Summary: start ------- 19:59:21 INFO - PROCESS | 3381 | Number of tests: 6 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | [#0] dojo.html Cycles:165 Average:4608.49 Median:4762.57 stddev:480.72 (10.1%) stddev-sans-first:455.55 19:59:21 INFO - PROCESS | 3381 | Values: 2596.5 2602.4 2603.8 2644.2 2663.8 4523.2 4594.9 4601.0 4678.3 4740.4 4621.6 4629.6 4666.3 4676.2 4687.3 4230.9 4234.0 4301.9 4367.8 4451.9 4353.8 4385.0 4395.6 4417.4 4431.0 4239.2 4266.7 4288.2 4294.4 4334.7 4222.5 4322.9 4323.2 4326.0 4374.5 4263.5 4270.6 4274.8 4305.7 4376.3 4642.2 4704.8 4708.7 4720.9 4768.4 4898.6 4931.5 4947.5 4967.6 5026.8 4966.6 4969.2 4982.4 4992.0 5059.8 4679.1 4684.6 4686.3 4688.1 4691.4 4932.6 5082.9 5121.0 5137.6 5216.8 4911.2 4911.9 4938.8 4940.5 4961.9 4981.0 4982.8 4988.0 4990.1 4997.1 4770.3 4849.2 4887.7 4913.5 4944.4 4904.9 4905.6 4906.2 4908.2 4964.9 4161.8 4169.9 4177.8 4184.4 4231.0 3589.2 3618.7 3649.7 3666.0 3673.0 4243.6 4258.5 4273.6 4311.6 4315.1 4957.0 4963.4 4971.3 4972.3 5027.9 4174.7 4208.5 4251.4 4252.3 4259.6 4480.5 4507.6 4532.9 4558.7 4564.8 4699.4 4702.6 4735.6 4743.1 4798.0 4828.8 4860.6 4968.2 5037.8 5048.3 4686.5 4693.2 4705.6 4762.6 4775.7 4945.0 4948.6 4956.8 4964.8 4990.3 4837.7 4910.6 5002.4 5013.7 5071.6 4819.1 4857.0 4865.3 4870.3 4910.8 4854.1 4856.3 4857.5 4859.3 4902.5 4691.7 4773.6 4790.3 4809.0 4855.3 4826.6 4849.7 4893.3 4983.9 4993.6 4779.5 4781.1 4798.3 4828.4 4852.8 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | [#1] ext.html Cycles:180 Average:44138.16 Median:35465.32 stddev:81287.26 (229.2%) stddev-sans-first:81449.46 19:59:21 INFO - PROCESS | 3381 | Values: 566.7 574.7 577.3 587.4 609.9 33435.0 36940.0 37005.8 37026.0 37050.4 37401.0 37855.0 37917.6 37919.0 37934.1 7174.1 7344.5 7488.1 7491.4 9609.7 9465.8 9813.3 9831.3 9831.7 9834.8 9875.9 9919.8 9927.8 9932.4 9934.3 9820.7 9847.0 9865.1 9869.2 9872.0 9664.2 9719.3 9725.3 9731.0 9736.2 36746.3 37070.8 37144.4 37147.4 37186.6 2642.9 2844.5 2985.9 3062.6 3173.9 28067.4 28527.6 28545.6 28612.6 28621.9 3097.1 3142.3 3213.1 3310.3 3323.7 252050.0 253826.0 254065.0 254720.7 255362.0 30590.0 31199.4 48103.0 48685.8 48694.8 32512.2 32675.0 32715.0 32741.2 32780.7 12657.5 12787.2 12790.7 12870.5 12874.6 8775.3 9491.0 9788.7 9838.3 10233.6 7666.7 7704.6 7749.1 7750.0 7761.2 3047.3 3071.0 3083.7 3102.1 3103.8 748.4 822.8 860.8 921.5 927.5 25173.7 26813.9 27009.0 27052.2 29577.4 871.0 887.5 921.9 943.1 965.9 13667.6 14660.3 14688.7 14743.0 14805.1 394565.0 398988.0 399323.0 399459.0 399724.0 46955.0 47286.8 47349.8 47506.5 47510.3 1008.0 1080.7 1107.8 1153.7 1174.2 24670.6 27794.7 28130.7 28668.9 29078.6 39660.0 40182.8 40210.6 40211.0 40230.4 247164.0 248415.0 248544.0 248667.0 248793.0 24200.8 25418.0 25481.0 26404.2 26496.7 40737.0 40987.6 41114.0 41823.6 41955.6 34883.7 35101.0 35106.0 35358.6 35595.0 33109.8 33479.5 33812.7 34011.1 34084.3 34522.5 35139.5 35231.3 35572.0 35879.6 29996.6 32090.5 32207.0 32269.4 32571.8 24472.3 24872.1 24895.9 24936.6 25317.9 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | [#2] jquery.html Cycles:180 Average:23432.47 Median:5092.85 stddev:60443.21 (1186.8%) stddev-sans-first:60587.91 19:59:21 INFO - PROCESS | 3381 | Values: 342.9 365.9 368.3 370.5 386.5 12167.1 15836.5 16137.4 16275.7 17293.0 15919.6 16135.4 16170.8 16921.0 17044.7 5064.3 5121.4 5277.3 5334.3 5375.5 3404.1 5137.3 5379.4 5421.1 5421.4 5346.1 5453.3 5466.6 5478.0 5483.0 5254.2 5393.6 5424.4 5448.9 5454.5 5254.6 5255.8 5256.2 5261.5 5262.5 10254.3 13844.9 20244.4 20391.9 20415.9 1588.7 1683.8 1730.3 1731.3 1762.4 8480.5 8596.4 8714.8 8743.4 8956.1 1556.8 1680.4 1685.7 1709.3 1720.0 64714.0 65916.3 67603.0 71980.3 73229.0 9318.5 9410.2 9836.4 10147.9 10481.8 13941.8 13944.6 13948.9 13976.1 13984.7 6747.0 6944.1 6951.7 7158.7 7175.2 6471.3 6472.5 6619.1 6636.4 6672.3 4315.1 4319.5 4377.1 4522.2 4532.3 1561.7 1673.4 1814.6 1861.9 1862.9 721.6 795.4 822.4 829.7 840.6 15859.9 16252.9 16348.4 16564.8 17350.6 795.9 815.7 818.9 820.5 849.6 9085.4 9263.2 9400.9 9548.6 9621.7 355987.0 365973.0 366422.0 367271.0 367366.0 73391.6 73910.6 74520.3 76884.2 79821.0 859.4 860.0 898.6 919.3 920.2 14808.5 15086.0 15790.9 15936.4 16253.8 38469.8 38720.0 39188.8 39357.6 40033.0 51730.0 53441.5 54008.0 54465.8 55030.7 4637.6 4728.6 7167.7 7362.2 7541.7 11483.0 11746.8 12136.2 12202.3 12236.4 7537.2 8177.9 9796.6 9869.6 10792.8 10445.7 10514.6 10583.4 10596.7 10639.7 10504.6 10561.3 10624.5 10686.0 10782.5 6252.5 6962.1 7490.4 7764.6 7773.4 9514.3 10611.7 10717.1 10814.6 11077.8 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | [#3] mootools.html Cycles:180 Average:4786.95 Median:4876.29 stddev:2662.60 (54.6%) stddev-sans-first:2657.50 19:59:21 INFO - PROCESS | 3381 | Values: 1343.6 1366.1 1413.9 1617.7 1673.1 6975.9 7506.3 7508.6 7515.1 7524.1 6351.1 6988.1 7175.8 7215.7 7408.5 2123.4 2150.3 2151.7 2154.2 2167.5 2120.3 2147.6 2176.6 2187.8 2192.9 2123.4 2124.2 2124.8 2128.8 2149.5 2079.0 2079.1 2083.3 2088.3 2088.6 2057.2 2115.9 2117.8 2126.0 2127.0 7437.5 7534.4 7538.4 7541.8 7561.7 4278.4 4413.2 4414.3 4414.5 4420.6 2696.4 2755.5 2834.1 2846.8 2860.5 891.2 931.1 937.9 940.6 951.8 9875.0 9907.9 9922.2 9933.9 9960.8 3740.0 3849.5 3932.4 3986.8 4020.3 8593.2 8603.5 8606.7 8607.2 8626.8 4286.5 4289.1 4290.8 4293.9 4346.9 3583.1 3829.2 3924.4 3947.3 3961.7 3456.9 3534.7 3568.2 3601.9 3610.4 1131.1 1131.5 1143.2 1145.6 1150.6 605.6 623.1 663.5 727.0 740.2 4588.3 4666.4 4841.4 4919.9 5078.7 386.5 388.5 388.7 389.1 395.6 3238.6 3374.3 3378.6 3385.8 3430.6 8500.7 8750.8 8898.6 8956.0 9013.8 8852.2 8852.9 8857.4 8859.8 8860.2 6594.9 6656.1 6691.9 6713.4 6716.7 4759.8 4823.4 4875.2 4877.4 4964.0 8326.1 8347.5 8359.4 8364.5 8399.0 8097.8 8388.6 8400.7 8442.5 8654.6 5739.8 5909.4 5916.8 6155.6 6334.9 6409.4 6450.4 6643.6 6655.7 6842.3 5981.8 6192.0 6239.0 6274.0 6319.7 6240.7 6275.7 6284.8 6309.3 6371.0 5750.8 5835.7 5845.1 5854.4 5870.4 4264.1 4286.0 4305.1 4343.0 4482.5 4243.4 4297.7 4329.2 4432.9 4535.5 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | [#4] prototype.html Cycles:180 Average:4157.47 Median:4769.82 stddev:1221.54 (25.6%) stddev-sans-first:1189.48 19:59:21 INFO - PROCESS | 3381 | Values: 262.9 267.5 269.2 275.6 278.4 4767.9 4819.4 4826.4 4836.8 4839.2 4474.9 4576.8 4729.9 4731.3 4771.7 3761.1 3761.7 3768.2 3772.5 3774.9 3770.5 3770.7 3777.5 3779.8 3781.2 3547.8 3581.2 3706.9 3736.1 3758.8 3718.6 3719.1 3723.1 3726.6 3737.4 3230.4 3265.7 3272.3 3284.2 3291.0 4391.4 4614.0 4651.9 4665.0 4672.1 4175.5 4198.1 4198.6 4210.2 4214.8 4992.3 5009.7 5027.8 5044.1 5044.7 3501.1 3501.6 3516.3 3516.7 3520.4 4972.9 5224.3 5243.3 5244.4 5254.4 3539.3 3551.1 3552.0 3590.3 3600.5 3599.6 3640.3 3640.4 3642.9 3650.6 3957.4 4204.6 4214.5 4215.1 4217.0 5012.4 5020.6 5034.2 5044.9 5050.7 1172.6 1237.8 1250.7 1252.5 1255.2 813.8 846.0 848.8 855.8 857.1 4387.2 4391.5 4395.4 4407.8 4424.3 5111.8 5125.2 5125.5 5137.6 5147.2 4223.3 4389.6 4396.6 4477.9 4502.6 2765.3 2781.1 2794.2 2794.4 2799.0 4944.6 4949.4 4953.7 4962.6 4964.9 5116.8 5274.8 5293.2 5311.2 5345.4 4894.7 4904.9 4918.3 4924.4 4934.5 5182.8 5225.3 5232.9 5235.5 5236.5 4996.9 5033.5 5056.5 5065.8 5107.4 4839.4 4845.1 4878.8 4882.9 4899.3 3585.5 3585.9 3586.8 3596.6 3600.1 4963.2 5134.8 5178.8 5181.2 5184.6 4959.1 4990.8 5002.5 5021.3 5025.5 4993.2 5028.7 5035.2 5048.7 5057.8 4757.6 4808.8 4954.3 4955.5 5006.1 4938.0 5074.3 5133.5 5135.7 5140.7 4968.0 4993.3 4993.9 4998.9 5016.2 19:59:21 INFO - PROCESS | 3381 | 19:59:21 INFO - PROCESS | 3381 | [#5] yui.html Cycles:180 Average:17536.32 Median:612.69 stddev:26646.15 (4349.0%) stddev-sans-first:26690.33 19:59:21 INFO - PROCESS | 3381 | Values: 537.1 584.3 613.1 614.7 659.4 13317.7 14543.1 14584.5 14614.6 14693.3 12969.2 13796.2 13883.9 13888.2 13928.2 725.6 749.2 752.6 752.9 754.2 612.3 728.7 751.0 753.3 756.7 801.4 802.9 803.9 804.1 804.1 794.9 794.9 795.4 795.5 795.7 470.0 555.8 569.4 569.6 582.8 12955.4 13409.8 13418.3 13422.3 13429.2 11291.8 11709.5 11929.2 12104.4 12725.5 11569.5 11610.0 11677.1 11717.8 11745.5 4143.3 4162.3 4191.5 4234.6 4266.7 65677.7 66548.7 70591.3 70636.0 71957.6 9263.7 9510.1 9800.3 9931.9 9942.5 19674.0 20021.7 20030.6 20058.2 20065.5 6620.2 6729.6 6749.8 6751.3 7022.2 3816.9 3928.9 3944.2 3999.9 4000.8 2887.2 2999.6 2999.8 3010.1 3018.9 467.9 468.8 479.2 494.1 499.7 400.0 473.1 476.1 483.3 505.5 7017.2 7228.1 7353.2 7586.2 7706.4 394.2 406.2 409.4 425.5 451.0 3376.4 3497.9 3577.7 3642.1 3681.6 102704.0 103842.5 104133.0 105763.0 107198.0 92228.5 92409.0 92664.5 93189.5 94228.0 47083.0 60936.7 75382.6 76373.6 76716.0 6933.7 7260.4 7279.5 7304.5 7344.4 33010.7 33075.7 42487.6 47364.6 48565.8 36929.0 55023.7 66823.0 67888.0 68082.2 8191.9 8402.9 8484.5 8658.7 8838.9 9833.5 9863.5 9969.9 10692.0 10714.6 9257.6 9530.1 9675.8 10057.1 10069.5 9253.0 9391.7 9425.3 9691.0 9787.7 8224.0 8554.1 8613.4 8674.1 8719.4 6465.0 6673.7 6936.5 6959.0 7425.8 7545.8 7602.2 7761.5 7776.3 7884.4 19:59:21 INFO - PROCESS | 3381 | -------- Summary: end -------- 19:59:21 INFO - PROCESS | 3381 | 19:59:22 INFO - TEST-INFO | 3381: exit 0 19:59:22 INFO - TEST-OK | dromaeo_css | took 1127348ms 19:59:22 INFO - TEST-START | kraken 19:59:22 INFO - operating with platform_type : linux_ 19:59:22 INFO - Initialising browser for kraken test... 19:59:22 INFO - TEST-INFO | started process 3687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9teoMK/profile http://localhost:52470/getInfo.html) 19:59:27 INFO - PROCESS | 3687 | __metrics Screen width/height:1600/1200 19:59:27 INFO - PROCESS | 3687 | colorDepth:24 19:59:27 INFO - PROCESS | 3687 | Browser inner width/height: 1024/697 19:59:27 INFO - PROCESS | 3687 | __metrics 19:59:27 INFO - PROCESS | 3687 | 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" 19:59:27 INFO - PROCESS | 3687 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:59:28 INFO - PROCESS | 3687 | console.error: PushService: 19:59:28 INFO - PROCESS | 3687 | stateChangeProcessEnqueue: Error transitioning state 19:59:28 INFO - PROCESS | 3687 | UnknownError 19:59:28 INFO - TEST-INFO | 3687: exit 0 19:59:28 INFO - Browser initialized. 19:59:28 INFO - Running cycle 1/1 for kraken test... 19:59:28 INFO - TEST-INFO | started process 3768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9teoMK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:41 INFO - PROCESS | 3768 | RSS: Main: 182161408 19:59:41 INFO - PROCESS | 3768 | 19:59:43 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52470/tests/kraken/driver.html?testName=audio-beat-detection) 19:59:44 INFO - PROCESS | 3768 | RSS: Main: 234930176 19:59:44 INFO - PROCESS | 3768 | 19:59:47 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52470/tests/kraken/driver.html?testName=audio-dft) 19:59:48 INFO - PROCESS | 3768 | RSS: Main: 225927168 19:59:48 INFO - PROCESS | 3768 | 19:59:51 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52470/tests/kraken/driver.html?testName=audio-fft) 19:59:51 INFO - PROCESS | 3768 | RSS: Main: 303357952 19:59:51 INFO - PROCESS | 3768 | 19:59:54 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52470/tests/kraken/driver.html?testName=audio-oscillator) 19:59:54 INFO - PROCESS | 3768 | RSS: Main: 213340160 19:59:54 INFO - PROCESS | 3768 | 19:59:56 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:59:57 INFO - PROCESS | 3768 | RSS: Main: 214605824 19:59:57 INFO - PROCESS | 3768 | 20:00:00 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52470/tests/kraken/driver.html?testName=imaging-darkroom) 20:00:01 INFO - PROCESS | 3768 | RSS: Main: 253272064 20:00:01 INFO - PROCESS | 3768 | 20:00:04 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52470/tests/kraken/driver.html?testName=imaging-desaturate) 20:00:05 INFO - PROCESS | 3768 | RSS: Main: 252633088 20:00:05 INFO - PROCESS | 3768 | 20:00:08 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52470/tests/kraken/driver.html?testName=json-parse-financial) 20:00:08 INFO - PROCESS | 3768 | RSS: Main: 252133376 20:00:08 INFO - PROCESS | 3768 | 20:00:10 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:11 INFO - PROCESS | 3768 | RSS: Main: 215277568 20:00:11 INFO - PROCESS | 3768 | 20:00:13 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:13 INFO - PROCESS | 3768 | RSS: Main: 221630464 20:00:13 INFO - PROCESS | 3768 | 20:00:16 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:00:16 INFO - PROCESS | 3768 | RSS: Main: 222978048 20:00:16 INFO - PROCESS | 3768 | 20:00:20 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:20 INFO - PROCESS | 3768 | RSS: Main: 213975040 20:00:20 INFO - PROCESS | 3768 | 20:00:23 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:24 INFO - PROCESS | 3768 | RSS: Main: 219561984 20:00:24 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:52470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52470/tests/kraken/driver.html?testName=ai-astar) 20:00:26 INFO - PROCESS | 3768 | RSS: Main: 272318464 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | __start_tp_report 20:00:26 INFO - PROCESS | 3768 | _x_x_mozilla_page_load 20:00:26 INFO - PROCESS | 3768 | _x_x_mozilla_page_load_details 20:00:26 INFO - PROCESS | 3768 | |i|pagename|runs| 20:00:26 INFO - PROCESS | 3768 | |0;ai-astar;118;117;135;117;117;117;115;117;115;116 20:00:26 INFO - PROCESS | 3768 | |1;audio-beat-detection;156;132;155;185;122;142;151;128;184;125 20:00:26 INFO - PROCESS | 3768 | |2;audio-dft;161;161;160;160;163;160;161;161;161;158 20:00:26 INFO - PROCESS | 3768 | |3;audio-fft;76;77;75;185;77;75;75;76;165;88 20:00:26 INFO - PROCESS | 3768 | |4;audio-oscillator;85;84;149;84;85;84;138;82;82;139 20:00:26 INFO - PROCESS | 3768 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;117;117 20:00:26 INFO - PROCESS | 3768 | |6;imaging-darkroom;146;147;147;146;146;147;146;147;147;147 20:00:26 INFO - PROCESS | 3768 | |7;imaging-desaturate;95;96;96;96;95;96;96;96;96;96 20:00:26 INFO - PROCESS | 3768 | |8;json-parse-financial;63;64;65;66;65;65;65;68;65;64 20:00:26 INFO - PROCESS | 3768 | |9;json-stringify-tinderbox;66;66;66;66;66;66;66;68;66;66 20:00:26 INFO - PROCESS | 3768 | |10;stanford-crypto-aes;83;82;91;88;83;99;87;93;89;82 20:00:26 INFO - PROCESS | 3768 | |11;stanford-crypto-ccm;133;136;142;133;135;129;130;132;167;135 20:00:26 INFO - PROCESS | 3768 | |12;stanford-crypto-pbkdf2;176;176;171;170;170;172;174;172;172;169 20:00:26 INFO - PROCESS | 3768 | |13;stanford-crypto-sha256-iterative;67;67;69;67;69;68;68;68;67;66 20:00:26 INFO - PROCESS | 3768 | __end_tp_report 20:00:26 INFO - PROCESS | 3768 | __start_cc_report 20:00:26 INFO - PROCESS | 3768 | _x_x_mozilla_cycle_collect,1971 20:00:26 INFO - PROCESS | 3768 | __end_cc_report 20:00:26 INFO - PROCESS | 3768 | __startTimestamp1472612426566__endTimestamp 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | ------- Summary: start ------- 20:00:26 INFO - PROCESS | 3768 | Number of tests: 14 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#0] ai-astar Cycles:10 Average:118.40 Median:117.00 stddev:5.91 (5.1%) stddev-sans-first:6.27 20:00:26 INFO - PROCESS | 3768 | Values: 118.0 117.0 135.0 117.0 117.0 117.0 115.0 117.0 115.0 116.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.00 stddev:22.81 (14.9%) stddev-sans-first:24.01 20:00:26 INFO - PROCESS | 3768 | Values: 156.0 132.0 155.0 185.0 122.0 142.0 151.0 128.0 184.0 125.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 20:00:26 INFO - PROCESS | 3768 | Values: 161.0 161.0 160.0 160.0 163.0 160.0 161.0 161.0 161.0 158.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#3] audio-fft Cycles:10 Average:96.90 Median:76.00 stddev:41.61 (54.8%) stddev-sans-first:43.44 20:00:26 INFO - PROCESS | 3768 | Values: 76.0 77.0 75.0 185.0 77.0 75.0 75.0 76.0 165.0 88.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:84.00 stddev:28.32 (33.7%) stddev-sans-first:29.42 20:00:26 INFO - PROCESS | 3768 | Values: 85.0 84.0 149.0 84.0 85.0 84.0 138.0 82.0 82.0 139.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:00:26 INFO - PROCESS | 3768 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:00:26 INFO - PROCESS | 3768 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:00:26 INFO - PROCESS | 3768 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.33 (2.1%) stddev-sans-first:1.20 20:00:26 INFO - PROCESS | 3768 | Values: 63.0 64.0 65.0 66.0 65.0 65.0 65.0 68.0 65.0 64.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 20:00:26 INFO - PROCESS | 3768 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 68.0 66.0 66.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.50 stddev:5.56 (6.3%) stddev-sans-first:5.63 20:00:26 INFO - PROCESS | 3768 | Values: 83.0 82.0 91.0 88.0 83.0 99.0 87.0 93.0 89.0 82.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:135.00 stddev:11.07 (8.2%) stddev-sans-first:11.64 20:00:26 INFO - PROCESS | 3768 | Values: 133.0 136.0 142.0 133.0 135.0 129.0 130.0 132.0 167.0 135.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:2.44 (1.4%) stddev-sans-first:2.17 20:00:26 INFO - PROCESS | 3768 | Values: 176.0 176.0 171.0 170.0 170.0 172.0 174.0 172.0 172.0 169.0 20:00:26 INFO - PROCESS | 3768 | 20:00:26 INFO - PROCESS | 3768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 20:00:26 INFO - PROCESS | 3768 | Values: 67.0 67.0 69.0 67.0 69.0 68.0 68.0 68.0 67.0 66.0 20:00:26 INFO - PROCESS | 3768 | -------- Summary: end -------- 20:00:26 INFO - PROCESS | 3768 | 20:00:27 INFO - TEST-INFO | 3768: exit 0 20:00:27 INFO - TEST-OK | kraken | took 65721ms 20:00:27 INFO - SUITE-END | took 1193s 20:00:28 INFO - Completed test suite (00:19:53) 20:00:28 INFO - javascript benchmark 20:00:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.5070084701297, 2602.4144567472317, 2603.8437693738365, 2644.2463897789135, 2663.7602615764577, 4523.231050721377, 4594.862154135381, 4601.03378290559, 4678.251479763234, 4740.3600513930605, 4621.607163391116, 4629.606483448911, 4666.34671146039, 4676.181668208059, 4687.250039993602, 4230.9153816923645, 4233.978830105861, 4301.935470967938, 4367.847125350613, 4451.933221001671, 4353.804078816445, 4384.9561504384865, 4395.626371758404, 4417.403650507173, 4430.9778451107695, 4239.215745087169, 4266.679999000087, 4288.24955632763, 4294.420253265832, 4334.653227741773, 4222.451081359403, 4322.913541729148, 4323.200207961506, 4325.978370108161, 4374.496932852699, 4263.4883813942215, 4270.572942705736, 4274.786260686953, 4305.655547556188, 4376.321670141133, 4642.1876171670165, 4704.788284527204, 4708.74101924394, 4720.929186062178, 4768.403949506312, 4898.583620392235, 4931.50684931504, 4947.529984651453, 4967.602591792648, 5026.84919452417, 4966.602671786284, 4969.229769385751, 4982.427020892571, 4992.0, 5059.848204553832, 4679.134360143316, 4684.578387945033, 4686.297055441677, 4688.062387522441, 4691.413573303337, 4932.55606995365, 5082.898342033139, 5121.027004869063, 5137.5889928806355, 5216.817411390583, 4911.214205727067, 4911.901761964741, 4938.753062346868, 4940.481249468754, 4961.900761984813, 4980.975095124501, 4982.750862456863, 4987.975060124749, 4990.101781679333, 4997.0505603935135, 4770.284457331359, 4849.151398505318, 4887.657863949489, 4913.533214344631, 4944.431390390151, 4904.8773780655765, 4905.583025442806, 4906.165951788204, 4908.165611845995, 4964.90070198594, 4161.812718427678, 4169.937450938239, 4177.791110444527, 4184.351425529047, 4231.005713657288, 3589.1565482111682, 3618.7466877318334, 3649.671529562352, 3665.991852240655, 3673.0, 4243.575642435793, 4258.488981322261, 4273.551277115858, 4311.611954924072, 4315.09383029561, 4956.950430495721, 4963.354763880672, 4971.254311853251, 4972.279019542146, 5027.899442011212, 4174.7077704561, 4208.494980602286, 4251.426057482262, 4252.277112890816, 4259.595338442843, 4480.507144214133, 4507.5943165115295, 4532.909341813145, 4558.726476411426, 4564.8402305919135, 4699.389079419722, 4702.553257440538, 4735.59747421473, 4743.146233677971, 4798.016406636701, 4828.830990915301, 4860.562549370432, 4968.205087186033, 5037.848864534069, 5048.318477005704, 4686.531346865286, 4693.155232058262, 4705.623550115914, 4762.571368576845, 4775.689580177416, 4944.975275123601, 4948.554630083309, 4956.752162391938, 4964.751762411937, 4990.326305948795, 4837.733924634179, 4910.631702622246, 5002.424721156968, 5013.724245166551, 5071.644984851025, 4819.060283244734, 4857.0, 4865.294532292727, 4870.342503761947, 4910.779014944264, 4854.053459575349, 4856.295837103529, 4857.465678775403, 4859.2954021667365, 4902.485239049848, 4691.671582989158, 4773.641976851681, 4790.281457781361, 4808.951910480991, 4855.344528488608, 4826.638002149783, 4849.733264670336, 4893.314935908905, 4983.8504844854715, 4993.600511958962, 4779.450363208137, 4781.115493633689, 4798.280257961194, 4828.444728856086, 4852.8301509447], "value": 4577.938336640581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7449647658553, 574.718387989885, 577.3129975329358, 587.4125874125874, 609.9481544068753, 33435.0, 36940.0, 37005.81497092511, 37026.0, 37050.44424333634, 37401.0, 37855.0, 37917.62082379175, 37919.0, 37934.051648708795, 7174.098863801097, 7344.48588598797, 7488.063992001, 7491.400687944952, 9609.711708648716, 9465.810683786354, 9813.264005199602, 9831.31180817343, 9831.705048848546, 9834.803303933917, 9875.901240987607, 9919.768052188272, 9927.751806204831, 9932.35439696421, 9934.30459867806, 9820.705378838646, 9846.9507652462, 9865.062819032217, 9869.161121304698, 9872.012798720143, 9664.226861851035, 9719.271054670928, 9725.319227654067, 9730.978247284003, 9736.172425343855, 36746.265074698626, 37070.81464592687, 37144.44283335752, 37147.442788358196, 37186.628133718856, 2642.9074982375523, 2844.459552684983, 2985.880564777406, 3062.6018617579793, 3173.9206519836957, 28067.43865122686, 28527.57208641872, 28545.57181642277, 28612.570811437847, 28621.856890715415, 3097.117321563366, 3142.292984078587, 3213.1485156433564, 3310.337932413527, 3323.7008669219886, 252050.0, 253826.0, 254065.0, 254720.72639636867, 255362.0, 30590.0, 31199.376012479624, 48103.0, 48685.756571216916, 48694.75652621714, 32512.187195320304, 32675.0, 32715.0, 32741.181470462954, 32780.67219327824, 12657.531781302558, 12787.232766034067, 12790.680232994064, 12870.549530766379, 12874.61376158698, 8775.254103401156, 9490.952545237229, 9788.657396991071, 9838.3113182078, 10233.641822536176, 7666.65500052499, 7704.614769261514, 7749.147593764681, 7749.961250193713, 7761.223877612194, 3047.2991212020916, 3070.9846450767604, 3083.676213997498, 3102.069379186235, 3103.7672174586996, 748.3788455581854, 822.8151461894852, 860.7934095817084, 921.4609453469661, 927.5130556457914, 25173.748262517507, 26813.86593067061, 27009.0, 27052.188434347, 29577.408451830845, 870.9912900871037, 887.4852585500523, 921.9308551858637, 943.0522325063267, 965.8696076029646, 13667.589972300846, 14660.266986650624, 14688.706225875423, 14743.010597038132, 14805.111693298437, 394565.0, 398988.0, 399323.0, 399459.0, 399724.0, 46955.0, 47286.763566182635, 47349.76325118421, 47506.52493475021, 47510.287345689845, 1007.9546420411099, 1080.7082087836397, 1107.8061339265596, 1153.6942710181977, 1174.1663418972455, 24670.629940551265, 27794.722052779212, 28130.71869281281, 28668.856655717424, 29078.563821543117, 39660.0, 40182.79908600439, 40210.597894020684, 40211.0, 40230.39654405245, 247164.0, 248415.0, 248544.0, 248667.0, 248793.0, 24200.75799241985, 25418.0, 25481.0, 26404.20787376382, 26496.735032649427, 40737.0, 40987.59012409838, 41114.0, 41823.58176418197, 41955.58044419639, 34883.65116348804, 35101.0, 35106.0, 35358.646413535535, 35595.0, 33109.83445082759, 33479.49780753339, 33812.66187338095, 34011.14972125716, 34084.31831363408, 34522.48216276808, 35139.47290790589, 35231.295374092886, 35572.0, 35879.64120358763, 29996.550051748804, 32090.518642220854, 32207.0, 32269.35461290808, 32571.837140814143, 24472.265832025067, 24872.058339401956, 24895.87552062228, 24936.625950610392, 25317.87341063283], "value": 16221.564507405785, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.9082596163405, 365.87560229521966, 368.25796021017635, 370.50352527612995, 386.5438782236959, 12167.08746843987, 15836.524904252876, 16137.354505819767, 16275.674486510263, 17293.04888231147, 15919.602009949756, 16135.354585816553, 16170.83829161708, 16921.0, 17044.744328835077, 5064.316317297164, 5121.385433747955, 5277.287566178555, 5334.306540149775, 5375.543078838284, 3404.114930118175, 5137.280780690707, 5379.408265090857, 5421.051316019701, 5421.430749771276, 5346.091164502024, 5453.345598528163, 5466.562674986011, 5477.972610136963, 5483.0, 5254.238135470336, 5393.622446428752, 5424.376196737347, 5448.91826622601, 5454.53636440901, 5254.605904557174, 5255.842324730264, 5256.21288761819, 5261.500157485033, 5262.526372626444, 10254.333468324536, 13844.861551384458, 20244.392668219978, 20391.898040509703, 20415.897920510302, 1588.6822635472836, 1683.7895263092114, 1730.3165249726414, 1731.3420900058022, 1762.3831658919403, 8480.533570653673, 8596.398252122353, 8714.825703485958, 8743.387962842604, 8956.104389561056, 1556.766485027255, 1680.3530640703295, 1685.7104315198883, 1709.2564734340601, 1719.9570010749705, 64714.0, 65916.3408365915, 67603.0, 71980.28019719788, 73229.0, 9318.534073296309, 9410.153086222273, 9836.360636558744, 10147.904889008923, 10481.842772358421, 13941.790873136912, 13944.58166255014, 13948.86051139496, 13976.091554048955, 13984.650383740487, 6747.0, 6944.062551555577, 6951.7219311228, 7158.749443769547, 7175.210726820045, 6471.320511346241, 6472.482201423874, 6619.106420633153, 6636.435902948207, 6672.332766723386, 4315.136972605429, 4319.503257125408, 4377.124575084932, 4522.23122069249, 4532.252178390595, 1561.73450513413, 1673.380849085846, 1814.609858880347, 1861.9092306770697, 1862.9254829806928, 721.6463932673057, 795.3994733975811, 822.4078663362369, 829.7344849648175, 840.5923127283263, 15859.920700396424, 16252.918735406483, 16348.427805027004, 16564.75152872708, 17350.56623584395, 795.908470525897, 815.7226542975417, 818.9385796065319, 820.5281962871372, 849.6049337058174, 9085.364024518352, 9263.212626926652, 9400.90599094014, 9548.61805527785, 9621.663241786504, 355987.0, 365973.0, 366422.0, 367271.0, 367366.0, 73391.63304183444, 73910.63044684743, 74520.25479745242, 76884.23115768771, 79821.0, 859.4070091636751, 860.0, 898.5552151684827, 919.2783664823082, 920.204023519664, 14808.520847286572, 15086.0, 15790.921045395158, 15936.442224522087, 16253.837461625233, 38469.807650961564, 38720.0, 39188.804055980676, 39357.606423935395, 40033.0, 51730.0, 53441.46558534365, 54008.0, 54465.830125481494, 55030.72484637711, 4637.582617564435, 4728.621710263102, 7167.749128780468, 7362.239160314882, 7541.698332066875, 11482.987523024805, 11746.765064698488, 12136.150469467053, 12202.32887191213, 12236.449359778653, 7537.170911199654, 8177.918220817715, 9796.559154838193, 9869.555869986012, 10792.838107428237, 10445.738856528647, 10514.57941682324, 10583.417912014913, 10596.682099537025, 10639.734006649896, 10504.579816807547, 10561.26071175041, 10624.450131968426, 10686.0, 10782.514786834454, 6252.531060170414, 6962.094927659372, 7490.4007679386605, 7764.61176941162, 7773.37812974972, 9514.333996620448, 10611.681649550526, 10717.142628589538, 10814.621488247874, 11077.778444431227], "value": 7951.578332592848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.570057581574, 1366.1461586508433, 1413.922234277115, 1617.724986752252, 1673.0965278749477, 6975.895361569575, 7506.2869027442375, 7508.587027713474, 7515.060617422822, 7524.097108346999, 6351.142595749572, 6988.126484189476, 7175.82060448489, 7215.747448839292, 7408.518446300986, 2123.3948324727417, 2150.2689085710854, 2151.7310336207975, 2154.235246487498, 2167.501474660829, 2120.34269376493, 2147.5812216617765, 2176.564687062586, 2187.8030977212047, 2192.8684278943315, 2123.3948324727457, 2124.2140408049045, 2124.7768984256663, 2128.755193152784, 2149.5271040371094, 2079.0, 2079.116375540389, 2083.312506872728, 2088.33173384517, 2088.624047671426, 2057.2285392977633, 2115.925942592002, 2117.76704562498, 2126.011404696808, 2127.0322003488377, 7437.51656142349, 7534.397248220129, 7538.434617403662, 7541.849163016764, 7561.697532098709, 4278.4010238566625, 4413.249747542925, 4414.337849322627, 4414.470263568361, 4420.6242469390145, 2696.4472283182095, 2755.5453350197195, 2834.1214223590546, 2846.8434236117005, 2860.5280128778727, 891.1940854514685, 931.1386967055447, 937.8546325319518, 940.6378544260509, 951.8001219743862, 9874.9506252469, 9907.851382229272, 9922.156616687591, 9933.850992235122, 9960.750981225456, 3740.0462881964927, 3849.538055433366, 3932.4297976793205, 3986.80065996699, 4020.336644453691, 8593.22660960504, 8603.483790972561, 8606.741797746077, 8607.18231767981, 8626.827463450696, 4286.54991225923, 4289.056407590325, 4290.785460726951, 4293.871183864427, 4346.869593912188, 3583.1221350768706, 3829.215010922754, 3924.4113382992778, 3947.3092208863336, 3961.6830653547645, 3456.948145777815, 3534.699550538233, 3568.2167909030995, 3601.9099522511624, 3610.368185567515, 1131.0894729742472, 1131.4625552862324, 1143.1712008793725, 1145.633397312852, 1150.5685367987005, 605.6275390634728, 623.0654018971543, 663.5322097920954, 726.9531874101277, 740.2301606329464, 4588.26587745959, 4666.416697912761, 4841.443234028062, 4919.926201106986, 5078.67954331869, 386.5110635046668, 388.4891367851267, 388.6715725212191, 389.11670507946803, 395.5787086752599, 3238.611366636019, 3374.291398806229, 3378.577677790276, 3385.8318879986364, 3430.6054803697393, 8500.65997360111, 8750.82498350042, 8898.59956301968, 8956.0, 9013.774655633662, 8852.159044890725, 8852.911470885338, 8857.424267422597, 8859.822803544022, 8860.202581767671, 6594.934050659528, 6656.101426307387, 6691.899621505681, 6713.362230588086, 6716.697748601325, 4759.833405830779, 4823.445303790109, 4875.219964805614, 4877.365942427462, 4963.975180124076, 8326.084130745734, 8347.457415267989, 8359.373047021376, 8364.53995030255, 8398.958005209935, 8097.757067287991, 8388.58057097155, 8400.663973440995, 8442.493450392996, 8654.567271636519, 5739.799107031234, 5909.3795151508475, 5916.763329466773, 6155.630662160284, 6334.936650633619, 6409.391107844747, 6450.387213214737, 6643.56816806906, 6655.73377064912, 6842.315768423118, 5981.820545383645, 6192.018554062657, 6238.968805155945, 6273.96863015682, 6319.715612797527, 6240.719167637377, 6275.717592708431, 6284.780032698834, 6309.337519560564, 6371.0, 5750.769969201185, 5835.708214589338, 5845.064789633639, 5854.414558544111, 5870.354261031369, 4264.147170565837, 4285.985586774211, 4305.117450922616, 4343.0, 4482.484514280899, 4243.405923170821, 4297.720648157985, 4329.19909816685, 4432.911341773211, 4535.455745310584], "value": 3812.540635526926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.8593702369232, 267.46907388833176, 269.1682700455592, 275.6017554633555, 278.4056040353844, 4767.90464190716, 4819.445763737172, 4826.396700412449, 4836.830710925118, 4839.225723884179, 4474.888127796807, 4576.771161441931, 4729.858104256878, 4731.290306454025, 4771.737554434505, 3761.0973366392004, 3761.661450469457, 3768.1536047336745, 3772.4907137536493, 3774.924501509968, 3770.4909837171904, 3770.660640542351, 3777.527809023872, 3779.848806047755, 3781.1870447853707, 3547.840347184383, 3581.158427769472, 3706.8517259309597, 3736.140687641844, 3758.7932663703486, 3718.553773547178, 3719.107414220595, 3723.0506220913494, 3726.5900750917376, 3737.402015677506, 3230.4318067136683, 3265.746634821989, 3272.312814308998, 3284.211789170582, 3290.9506357404657, 4391.407160033418, 4613.953860461386, 4651.86044418668, 4664.976675116636, 4672.112298663277, 4175.54069052404, 4198.076423186894, 4198.6011328923705, 4210.179015092058, 4214.7681877496725, 4992.276119962621, 5009.670503216022, 5027.84916452507, 5044.117279476077, 5044.672096313728, 3501.072215862798, 3501.6323286054853, 3516.2594515714886, 3516.7186625069935, 3520.366334059868, 4972.850814475535, 5224.294720212799, 5243.2659427680155, 5244.370675518924, 5254.369475662945, 3539.309834582283, 3551.147724546142, 3551.982240088783, 3590.317839610466, 3600.5499312585926, 3599.6220396858475, 3640.2537479816574, 3640.3993341098953, 3642.8724994625063, 3650.5619325681087, 3957.3668213086344, 4204.579542045771, 4214.524916279278, 4215.093754842724, 4216.9578304217175, 5012.396033269391, 5020.5732512736095, 5034.194528875362, 5044.940562481846, 5050.72221027847, 1172.5661505242945, 1237.7957636989795, 1250.6560695808544, 1252.5303011370736, 1255.234307072685, 813.7802793245909, 845.9974929708316, 848.762346542969, 855.781775647206, 857.0572370392518, 4387.188370151533, 4391.5388884166705, 4395.384646149541, 4407.823687052482, 4424.269995450714, 5111.846644600668, 5125.15434953236, 5125.461826508237, 5137.640365174402, 5147.2279158126585, 4223.345381465878, 4389.58572784967, 4396.60430561251, 4477.910441791211, 4502.57225563571, 2765.3363192833576, 2781.1378472673537, 2794.2036519592225, 2794.421152049086, 2799.0483235699553, 4944.566075838039, 4949.406071271471, 4953.72754498506, 4962.627802914796, 4964.90070198594, 5116.820911268088, 5274.815381461631, 5293.200311893975, 5311.229871668664, 5345.438728933484, 4894.657373983858, 4904.901901961941, 4918.311436398907, 4924.4090709115135, 4934.4572097069295, 5182.844514664566, 5225.268462415341, 5232.869178270574, 5235.502627250406, 5236.45017273196, 4996.925046124238, 5033.546980771748, 5056.457780376873, 5065.797368105382, 5107.41264754558, 4839.370881785346, 4845.103655823684, 4878.8045379578625, 4882.90234195307, 4899.289603007615, 3585.515955345995, 3585.8924232273075, 3586.7847929124337, 3596.5504311961004, 3600.117971097098, 4963.205887058053, 5134.845954621367, 5178.792848286026, 5181.1969144782615, 5184.637075404686, 4959.107360675113, 4990.750462476934, 5002.52476014778, 5021.271915572294, 5025.547700706954, 4993.15116430215, 5028.723420211923, 5035.244713293036, 5048.737815546114, 5057.797688092435, 4757.5718185363485, 4808.807647694193, 4954.3311652926395, 4955.456848353445, 5006.123928312603, 4937.975310123426, 5074.340335756328, 5133.486651334837, 5135.666181698178, 5140.691558506502, 4968.0, 4993.300937868628, 4993.875153121201, 4998.925016124834, 5016.2224855147515], "value": 3759.892392661436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.1244870860497, 584.2972587545555, 613.1262950295827, 614.709110867179, 659.423004870738, 13317.733645327087, 14543.127412355267, 14584.489542865975, 14614.634634134125, 14693.33879975401, 12969.22184668918, 13796.241206733626, 13883.930580347109, 13888.23614701191, 13928.1643101414, 725.5719125715826, 749.1983577572, 752.5672738175543, 752.8682480565907, 754.2118486181926, 612.2622240200548, 728.7340120855876, 750.9586972716498, 753.3220101908272, 756.6784116750387, 801.3629164813958, 802.9478083924555, 803.9035315762087, 804.1034246814818, 804.1315379390273, 794.8887155798193, 794.9125596184415, 795.4153697032676, 795.49883573349, 795.6538905576093, 469.9953000469986, 555.822136916187, 569.3651578489995, 569.5785119011942, 582.7581553655228, 12955.417006234742, 13409.798853017213, 13418.26199559024, 13422.261775602337, 13429.194248345131, 11291.830622540669, 11709.455228553532, 11929.224600400947, 12104.394780260951, 12725.490980360775, 11569.479373428216, 11610.0, 11677.124215683858, 11717.824232636518, 11745.530178792924, 4143.295639741251, 4162.271602469556, 4191.455110835603, 4234.618884300427, 4266.679999000087, 65677.67161164212, 66548.66725666341, 70591.2940870595, 70636.0, 71957.64021179912, 9263.675771347971, 9510.1440870322, 9800.313978021613, 9931.900680993242, 9942.453165075991, 19674.0, 20021.69642009052, 20030.599388012157, 20058.197672092952, 20065.498362541053, 6620.172478440195, 6729.629870357177, 6749.831254218684, 6751.324867513307, 7022.192447868459, 3816.885493435201, 3928.9017774555864, 3944.2308749793515, 3999.900002499961, 4000.8199631016673, 2887.191586355824, 2999.580058791771, 2999.820010799359, 3010.142109498826, 3018.9245268868453, 467.8900458392275, 468.7632745463519, 479.24040395972776, 494.1056687395825, 499.6752111127796, 399.9680025598003, 473.0869422015543, 476.11680332982513, 483.32817383836493, 505.5323825461507, 7017.228104908456, 7228.132624085143, 7353.154387245429, 7586.203448637813, 7706.38348932084, 394.19387352863464, 406.1673569183163, 409.41453721179, 425.5404163503409, 450.9537872136677, 3376.392249395083, 3497.877574284939, 3577.678008979204, 3642.0894776305922, 3681.5766186888313, 102704.0, 103842.48078759557, 104133.0, 105763.0, 107198.0, 92228.53885730663, 92409.0, 92664.53667731618, 93189.5340523293, 94228.0, 47083.0, 60936.69531652313, 75382.62308688641, 76373.6181319101, 76716.0, 6933.653317334012, 7260.382867456114, 7279.490435669452, 7304.5252058616015, 7344.4332240590065, 33010.66989330076, 33075.66924330726, 42487.57512424836, 47364.60025778685, 48565.75717121392, 36929.0, 55023.72488137534, 66823.0, 67888.0, 68082.19178082152, 8191.877121843297, 8402.915970840213, 8484.499090520727, 8658.653653854028, 8838.911610884066, 9833.5083245836, 9863.506824658594, 9969.850452243078, 10692.0, 10714.624988125379, 9257.629694812133, 9530.094641009093, 9675.758106047406, 10057.094861462503, 10069.546870390703, 9253.0, 9391.671291504765, 9425.340226184102, 9690.95154524223, 9787.657431989846, 8224.0, 8554.101819309131, 8613.397062205586, 8674.132586741276, 8719.389642725202, 6465.0, 6673.733050677918, 6936.549124306904, 6959.0, 7425.8143546411775, 7545.849083018418, 7602.239776022575, 7761.495502792301, 7776.339011184113, 7884.369250459835], "value": 6105.511164015363, "unit": "score"}], "name": "dromaeo_css", "value": 6103.275371424256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 135.0, 117.0, 117.0, 117.0, 115.0, 117.0, 115.0, 116.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 155.0, 185.0, 122.0, 142.0, 151.0, 128.0, 184.0, 125.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 163.0, 160.0, 161.0, 161.0, 161.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 185.0, 77.0, 75.0, 75.0, 76.0, 165.0, 88.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 149.0, 84.0, 85.0, 84.0, 138.0, 82.0, 82.0, 139.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 68.0, 65.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 68.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 91.0, 88.0, 83.0, 99.0, 87.0, 93.0, 89.0, 82.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 142.0, 133.0, 135.0, 129.0, 130.0, 132.0, 167.0, 135.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 171.0, 170.0, 170.0, 172.0, 174.0, 172.0, 172.0, 169.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1580.2, "alertThreshold": 2.0}]} 20:00:28 INFO - Return code: 0 20:00:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:00:28 INFO - # TBPL SUCCESS # 20:00:28 INFO - Running post-action listener: _resource_record_post_action 20:00:28 INFO - [mozharness: 2016-08-31 03:00:28.327484Z] Finished run-tests step (success) 20:00:28 INFO - Running post-run listener: _resource_record_post_run 20:00:28 INFO - Total resource usage - Wall time: 1210s; CPU: 13.0%; Read bytes: 7987200; Write bytes: 420319232; Read time: 2184; Write time: 540964 20:00:28 INFO - TinderboxPrint: CPU usage
13.0% 20:00:28 INFO - TinderboxPrint: I/O read bytes / time
7,987,200 / 2,184 20:00:28 INFO - TinderboxPrint: I/O write bytes / time
420,319,232 / 540,964 20:00:28 INFO - TinderboxPrint: CPU idle
8,395.7 (86.9%) 20:00:28 INFO - TinderboxPrint: CPU user
1,200.7 (12.4%) 20:00:28 INFO - TinderboxPrint: Swap in / out
0 / 0 20:00:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4661248; Read time: 0; Write time: 300 20:00:28 INFO - run-tests - Wall time: 1194s; CPU: 13.0%; Read bytes: 5615616; Write bytes: 415657984; Read time: 1664; Write time: 540664 20:00:28 INFO - Running post-run listener: _upload_blobber_files 20:00:28 INFO - Blob upload gear active. 20:00:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:00:28 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 20:00:28 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'] 20:00:28 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 20:00:29 INFO - (blobuploader) - INFO - Open directory for files ... 20:00:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:00:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:00:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:32 INFO - (blobuploader) - INFO - Done attempting. 20:00:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:00:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:00:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:34 INFO - (blobuploader) - INFO - Done attempting. 20:00:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:00:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:00:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:35 INFO - (blobuploader) - INFO - Done attempting. 20:00:35 INFO - (blobuploader) - INFO - Iteration through files over. 20:00:35 INFO - Return code: 0 20:00:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:00:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:00:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2778623f93f3477761c1ae34dad4e0b08cb9841efb471372db7ccc502bca38bf3b71ba66c031fb5aa5c0da03cebe357e0ff8a8823e890cf1ce52e48b54b5ac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7b8f5afeecbd5ed38b65d9b7dab491da17b9ec9f2a30806e7482e26705f51baa05235cf0b553a43d852e6e4f27ba250e24a9b4ac978e57f4abf900cf90e671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66a3ab2f04b3e6d3736a0c45e663091d8c53189d1dcaf8d4fd0cb9296f80822d6bb41fac91f43e9b8c2e854df76ef71b145ee6a7f5018a1183a6a6bad7d3e818"} 20:00:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:00:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:00:35 INFO - Contents: 20:00:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2778623f93f3477761c1ae34dad4e0b08cb9841efb471372db7ccc502bca38bf3b71ba66c031fb5aa5c0da03cebe357e0ff8a8823e890cf1ce52e48b54b5ac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7b8f5afeecbd5ed38b65d9b7dab491da17b9ec9f2a30806e7482e26705f51baa05235cf0b553a43d852e6e4f27ba250e24a9b4ac978e57f4abf900cf90e671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66a3ab2f04b3e6d3736a0c45e663091d8c53189d1dcaf8d4fd0cb9296f80822d6bb41fac91f43e9b8c2e854df76ef71b145ee6a7f5018a1183a6a6bad7d3e818"} 20:00:35 INFO - Running post-run listener: copy_logs_to_upload_dir 20:00:35 INFO - Copying logs to upload dir... 20:00:35 INFO - mkdir: /builds/slave/test/build/upload/logs 20:00:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.685265 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-08-30 20:00:35.363762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 20:00:35.367736) ========= 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=af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789 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/2778623f93f3477761c1ae34dad4e0b08cb9841efb471372db7ccc502bca38bf3b71ba66c031fb5aa5c0da03cebe357e0ff8a8823e890cf1ce52e48b54b5ac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7b8f5afeecbd5ed38b65d9b7dab491da17b9ec9f2a30806e7482e26705f51baa05235cf0b553a43d852e6e4f27ba250e24a9b4ac978e57f4abf900cf90e671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66a3ab2f04b3e6d3736a0c45e663091d8c53189d1dcaf8d4fd0cb9296f80822d6bb41fac91f43e9b8c2e854df76ef71b145ee6a7f5018a1183a6a6bad7d3e818"} build_url:https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/L1gjom_5SlG8XGSKJ31icA/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/2778623f93f3477761c1ae34dad4e0b08cb9841efb471372db7ccc502bca38bf3b71ba66c031fb5aa5c0da03cebe357e0ff8a8823e890cf1ce52e48b54b5ac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de7b8f5afeecbd5ed38b65d9b7dab491da17b9ec9f2a30806e7482e26705f51baa05235cf0b553a43d852e6e4f27ba250e24a9b4ac978e57f4abf900cf90e671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66a3ab2f04b3e6d3736a0c45e663091d8c53189d1dcaf8d4fd0cb9296f80822d6bb41fac91f43e9b8c2e854df76ef71b145ee6a7f5018a1183a6a6bad7d3e818"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 20:00:35.395243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 20:00:35.395578) ========= 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=af724c981e2a0f424dbabf99000001e7-1472611174.529519-1531427789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 20:00:35.479968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 20:00:35.480312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 20:00:35.480629) ========= ========= Total master_lag: 0.18 =========