builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1471351055.63 results: success (0) buildid: 20160816043224 builduid: f0625632b20e4d7f98d2e6dc547ee82c revision: dd8193695d2d56667f22a32b77adc243a034cfd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.626169) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.626719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.627000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.640156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.640434) ========= 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=eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 05:37: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% 28.6M=0s 2016-08-16 05:37:35 (28.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.798963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.799517) ========= 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=eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016131 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.851714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:35.852321) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd8193695d2d56667f22a32b77adc243a034cfd2 --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 dd8193695d2d56667f22a32b77adc243a034cfd2 --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=eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 05:37:35,955 truncating revision to first 12 chars 2016-08-16 05:37:35,955 Setting DEBUG logging. 2016-08-16 05:37:35,955 attempt 1/10 2016-08-16 05:37:35,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd8193695d2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 05:37:36,292 unpacking tar archive at: fx-team-dd8193695d2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:36.531245) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:36.531569) ========= script_repo_revision: dd8193695d2d56667f22a32b77adc243a034cfd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:36.531983) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:36.532260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:37:36.542839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-16 05:37:36.543105) ========= /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=eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:37:36 INFO - MultiFileLogger online at 20160816 05:37:36 in /builds/slave/test 05:37: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 05:37:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:37:36 INFO - {'append_to_log': False, 05:37:36 INFO - 'base_work_dir': '/builds/slave/test', 05:37:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:37:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:37:36 INFO - 'branch': 'Fx-Team-Non-PGO', 05:37:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:36 INFO - 'config_files': ('talos/linux_config.py',), 05:37:36 INFO - 'default_actions': ('clobber', 05:37:36 INFO - 'read-buildbot-config', 05:37:36 INFO - 'download-and-extract', 05:37:36 INFO - 'populate-webroot', 05:37:36 INFO - 'create-virtualenv', 05:37:36 INFO - 'install', 05:37:36 INFO - 'run-tests'), 05:37:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:36 INFO - 'download_minidump_stackwalk': True, 05:37:36 INFO - 'download_symbols': 'ondemand', 05:37:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:36 INFO - 'installer_path': 'installer.exe', 05:37:36 INFO - 'log_level': 'info', 05:37:36 INFO - 'log_name': 'talos', 05:37:36 INFO - 'log_to_console': True, 05:37:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:37:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:37:36 INFO - 'opt_config_files': (), 05:37:36 INFO - 'pip_index': False, 05:37:36 INFO - 'sps_profile': False, 05:37:36 INFO - 'sps_profile_interval': 0, 05:37:36 INFO - 'suite': 'dromaeojs', 05:37:36 INFO - 'system_bits': '32', 05:37:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:36 INFO - 'title': 'talos-linux64-ix-010', 05:37:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:36 INFO - 'use_talos_json': True, 05:37:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:37:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:36 INFO - 'work_dir': 'build'} 05:37:36 INFO - [mozharness: 2016-08-16 12:37:36.739255Z] Running clobber step. 05:37:36 INFO - Running pre-action listener: _resource_record_pre_action 05:37:36 INFO - Running main action method: clobber 05:37:36 INFO - rmtree: /builds/slave/test/build 05:37:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:37:37 INFO - Running post-action listener: _resource_record_post_action 05:37:37 INFO - [mozharness: 2016-08-16 12:37:37.206059Z] Finished clobber step (success) 05:37:37 INFO - [mozharness: 2016-08-16 12:37:37.206160Z] Running read-buildbot-config step. 05:37:37 INFO - Running pre-action listener: _resource_record_pre_action 05:37:37 INFO - Running main action method: read_buildbot_config 05:37:37 INFO - Using buildbot properties: 05:37:37 INFO - { 05:37:37 INFO - "project": "", 05:37:37 INFO - "product": "firefox", 05:37:37 INFO - "script_repo_revision": "production", 05:37:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:37:37 INFO - "repository": "", 05:37:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:37:37 INFO - "buildid": "20160816043224", 05:37:37 INFO - "pgo_build": "False", 05:37:37 INFO - "basedir": "/builds/slave/test", 05:37:37 INFO - "buildnumber": 1871, 05:37:37 INFO - "slavename": "talos-linux64-ix-010", 05:37:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:37:37 INFO - "platform": "ubuntu64_hw", 05:37:37 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 05:37:37 INFO - "branch": "fx-team", 05:37:37 INFO - "repo_path": "integration/fx-team", 05:37:37 INFO - "revision": "dd8193695d2d56667f22a32b77adc243a034cfd2", 05:37:37 INFO - "stage_platform": "linux64", 05:37:37 INFO - "builduid": "f0625632b20e4d7f98d2e6dc547ee82c", 05:37:37 INFO - "slavebuilddir": "test" 05:37:37 INFO - } 05:37:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:37:37 INFO - Running post-action listener: _resource_record_post_action 05:37:37 INFO - [mozharness: 2016-08-16 12:37:37.208572Z] Finished read-buildbot-config step (success) 05:37:37 INFO - [mozharness: 2016-08-16 12:37:37.208661Z] Running download-and-extract step. 05:37:37 INFO - Running pre-action listener: _resource_record_pre_action 05:37:37 INFO - Running main action method: download_and_extract 05:37:37 INFO - mkdir: /builds/slave/test/build/tests 05:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:37 INFO - trying https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:37 INFO - Downloaded 1361 bytes. 05:37:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:37:37 INFO - Using the following test package requirements: 05:37:37 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:37:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'jsshell-linux-x86_64.zip'], 05:37:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:37 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:37 INFO - trying https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:38 INFO - Downloaded 20266179 bytes. 05:37:38 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 05:37:42 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 05:37:42 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')]} 05:37:42 INFO - trying https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:37:42 INFO - Downloading https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:43 INFO - Downloaded 20266179 bytes. 05:37:43 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 05:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:48 INFO - trying https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:48 INFO - Downloading https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:48 INFO - Downloaded 14413719 bytes. 05:37:48 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 05:37: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')]} 05:37:49 INFO - trying https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:37:49 INFO - Downloading https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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 05:37:50 INFO - Downloaded 55628221 bytes. 05:37:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:37:50 INFO - mkdir: /builds/slave/test/properties 05:37:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:50 INFO - Contents: 05:37:50 INFO - build_url:https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:37:51 INFO - Running post-action listener: _resource_record_post_action 05:37:51 INFO - Running post-action listener: set_extra_try_arguments 05:37:51 INFO - [mozharness: 2016-08-16 12:37:51.314236Z] Finished download-and-extract step (success) 05:37:51 INFO - [mozharness: 2016-08-16 12:37:51.314460Z] Running populate-webroot step. 05:37:51 INFO - Running pre-action listener: _resource_record_pre_action 05:37:51 INFO - Running main action method: populate_webroot 05:37:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:51 INFO - '--tppagecycles', 05:37:51 INFO - '7'], 05:37:51 INFO - 'tests': ['tsvgm']}}, 05:37:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:37:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:37:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['damp', 'tps']}, 05:37:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'tests': ['damp', 'tps']}, 05:37:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['dromaeo_dom']}, 05:37:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['basic_compositor_video']}, 05:37:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:37:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tsvgx', 05:37:51 INFO - 'tsvgr_opacity', 05:37:51 INFO - 'tart', 05:37:51 INFO - 'tscrollx', 05:37:51 INFO - 'cart']}, 05:37:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:37:51 INFO - 'tsvgr_opacity', 05:37:51 INFO - 'tart', 05:37:51 INFO - 'tscrollx', 05:37:51 INFO - 'cart']}, 05:37:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tp5o']}, 05:37:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'tests': ['tp5o']}, 05:37:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s', 05:37:51 INFO - '--xperf_path', 05:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:51 INFO - 'tests': ['tp5n']}, 05:37:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--xperf_path', 05:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:51 INFO - 'tests': ['tp5n']}}, 05:37:51 INFO - 'talos.zip': {'path': '', 05:37:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:51 INFO - Running post-action listener: _resource_record_post_action 05:37:51 INFO - [mozharness: 2016-08-16 12:37:51.337172Z] Finished populate-webroot step (success) 05:37:51 INFO - [mozharness: 2016-08-16 12:37:51.337261Z] Running create-virtualenv step. 05:37:51 INFO - Running pre-action listener: _resource_record_pre_action 05:37:51 INFO - Running main action method: create_virtualenv 05:37:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:37:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:51 INFO - Using real prefix '/usr' 05:37:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:53 INFO - Installing pip.................done. 05:37:53 INFO - Return code: 0 05:37:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:53 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')]} 05:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:53 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')]} 05:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:53 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 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:37:53 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 05:37:53 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 05:37:53 INFO - Using env: {'DISPLAY': ':0', 05:37:53 INFO - 'HOME': '/home/cltbld', 05:37:53 INFO - 'LANG': 'en_US.UTF-8', 05:37:53 INFO - 'LANGUAGE': 'en_US:en', 05:37:53 INFO - 'LOGNAME': 'cltbld', 05:37:53 INFO - 'MAIL': '/var/mail/cltbld', 05:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:53 INFO - 'MOZ_NO_REMOTE': '1', 05:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:53 INFO - 'NO_EM_RESTART': '1', 05:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:53 INFO - 'PWD': '/builds/slave/test', 05:37:53 INFO - 'SHELL': '/bin/bash', 05:37:53 INFO - 'SHLVL': '1', 05:37:53 INFO - 'TERM': 'linux', 05:37:53 INFO - 'TMOUT': '86400', 05:37:53 INFO - 'USER': 'cltbld', 05:37:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:53 INFO - '_': '/tools/buildbot/bin/python'} 05:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:37:54 INFO - Cleaning up... 05:37:54 INFO - Return code: 0 05:37:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:37:54 INFO - Using env: {'DISPLAY': ':0', 05:37:54 INFO - 'HOME': '/home/cltbld', 05:37:54 INFO - 'LANG': 'en_US.UTF-8', 05:37:54 INFO - 'LANGUAGE': 'en_US:en', 05:37:54 INFO - 'LOGNAME': 'cltbld', 05:37:54 INFO - 'MAIL': '/var/mail/cltbld', 05:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:54 INFO - 'MOZ_NO_REMOTE': '1', 05:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:54 INFO - 'NO_EM_RESTART': '1', 05:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:54 INFO - 'PWD': '/builds/slave/test', 05:37:54 INFO - 'SHELL': '/bin/bash', 05:37:54 INFO - 'SHLVL': '1', 05:37:54 INFO - 'TERM': 'linux', 05:37:54 INFO - 'TMOUT': '86400', 05:37:54 INFO - 'USER': 'cltbld', 05:37:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:54 INFO - '_': '/tools/buildbot/bin/python'} 05:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:54 INFO - Downloading/unpacking psutil>=3.1.1 05:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:56 INFO - Installing collected packages: psutil 05:37:56 INFO - Running setup.py install for psutil 05:37:56 INFO - building 'psutil._psutil_linux' extension 05:37:56 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 05:37:56 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 05:37:56 INFO - building 'psutil._psutil_posix' extension 05:37:56 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 05:37:56 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 05:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:56 INFO - Successfully installed psutil 05:37:56 INFO - Cleaning up... 05:37:56 INFO - Return code: 0 05:37:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:37: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 mozsystemmonitor==0.3 05:37:56 INFO - Using env: {'DISPLAY': ':0', 05:37:56 INFO - 'HOME': '/home/cltbld', 05:37:56 INFO - 'LANG': 'en_US.UTF-8', 05:37:56 INFO - 'LANGUAGE': 'en_US:en', 05:37:56 INFO - 'LOGNAME': 'cltbld', 05:37:56 INFO - 'MAIL': '/var/mail/cltbld', 05:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:56 INFO - 'MOZ_NO_REMOTE': '1', 05:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:56 INFO - 'NO_EM_RESTART': '1', 05:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:56 INFO - 'PWD': '/builds/slave/test', 05:37:56 INFO - 'SHELL': '/bin/bash', 05:37:56 INFO - 'SHLVL': '1', 05:37:56 INFO - 'TERM': 'linux', 05:37:56 INFO - 'TMOUT': '86400', 05:37:56 INFO - 'USER': 'cltbld', 05:37:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:56 INFO - '_': '/tools/buildbot/bin/python'} 05:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:37:59 INFO - Installing collected packages: mozsystemmonitor 05:37:59 INFO - Running setup.py install for mozsystemmonitor 05:37:59 INFO - Successfully installed mozsystemmonitor 05:37:59 INFO - Cleaning up... 05:37:59 INFO - Return code: 0 05:37:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:37:59 INFO - Using env: {'DISPLAY': ':0', 05:37:59 INFO - 'HOME': '/home/cltbld', 05:37:59 INFO - 'LANG': 'en_US.UTF-8', 05:37:59 INFO - 'LANGUAGE': 'en_US:en', 05:37:59 INFO - 'LOGNAME': 'cltbld', 05:37:59 INFO - 'MAIL': '/var/mail/cltbld', 05:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:59 INFO - 'MOZ_NO_REMOTE': '1', 05:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:59 INFO - 'NO_EM_RESTART': '1', 05:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:59 INFO - 'PWD': '/builds/slave/test', 05:37:59 INFO - 'SHELL': '/bin/bash', 05:37:59 INFO - 'SHLVL': '1', 05:37:59 INFO - 'TERM': 'linux', 05:37:59 INFO - 'TMOUT': '86400', 05:37:59 INFO - 'USER': 'cltbld', 05:37:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:59 INFO - '_': '/tools/buildbot/bin/python'} 05:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:59 INFO - Downloading/unpacking jsonschema==2.5.1 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:01 INFO - warning: no files found matching '*.txt' 05:38:01 INFO - no previously-included directories found matching 'build' 05:38:01 INFO - no previously-included directories found matching 'dist' 05:38:01 INFO - no previously-included directories found matching '.git*' 05:38:01 INFO - Installing collected packages: jsonschema, functools32 05:38:01 INFO - Running setup.py install for functools32 05:38:01 INFO - warning: no files found matching '*.txt' 05:38:01 INFO - no previously-included directories found matching 'build' 05:38:01 INFO - no previously-included directories found matching 'dist' 05:38:01 INFO - no previously-included directories found matching '.git*' 05:38:01 INFO - Successfully installed jsonschema functools32 05:38:01 INFO - Cleaning up... 05:38:01 INFO - Return code: 0 05:38:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', '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 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:38: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:38: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 functools32==3.2.3-2 05:38:01 INFO - Using env: {'DISPLAY': ':0', 05:38:01 INFO - 'HOME': '/home/cltbld', 05:38:01 INFO - 'LANG': 'en_US.UTF-8', 05:38:01 INFO - 'LANGUAGE': 'en_US:en', 05:38:01 INFO - 'LOGNAME': 'cltbld', 05:38:01 INFO - 'MAIL': '/var/mail/cltbld', 05:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:01 INFO - 'MOZ_NO_REMOTE': '1', 05:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:01 INFO - 'NO_EM_RESTART': '1', 05:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:01 INFO - 'PWD': '/builds/slave/test', 05:38:01 INFO - 'SHELL': '/bin/bash', 05:38:01 INFO - 'SHLVL': '1', 05:38:01 INFO - 'TERM': 'linux', 05:38:01 INFO - 'TMOUT': '86400', 05:38:01 INFO - 'USER': 'cltbld', 05:38:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:01 INFO - '_': '/tools/buildbot/bin/python'} 05:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:38:01 INFO - Cleaning up... 05:38:01 INFO - Return code: 0 05:38:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', '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 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:38: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 blobuploader==1.2.4 05:38:01 INFO - Using env: {'DISPLAY': ':0', 05:38:01 INFO - 'HOME': '/home/cltbld', 05:38:01 INFO - 'LANG': 'en_US.UTF-8', 05:38:01 INFO - 'LANGUAGE': 'en_US:en', 05:38:01 INFO - 'LOGNAME': 'cltbld', 05:38:01 INFO - 'MAIL': '/var/mail/cltbld', 05:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:01 INFO - 'MOZ_NO_REMOTE': '1', 05:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:01 INFO - 'NO_EM_RESTART': '1', 05:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:01 INFO - 'PWD': '/builds/slave/test', 05:38:01 INFO - 'SHELL': '/bin/bash', 05:38:01 INFO - 'SHLVL': '1', 05:38:01 INFO - 'TERM': 'linux', 05:38:01 INFO - 'TMOUT': '86400', 05:38:01 INFO - 'USER': 'cltbld', 05:38:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:01 INFO - '_': '/tools/buildbot/bin/python'} 05:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:04 INFO - Downloading docopt-0.6.1.tar.gz 05:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:04 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:04 INFO - Running setup.py install for blobuploader 05:38:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:04 INFO - Running setup.py install for requests 05:38:05 INFO - Running setup.py install for docopt 05:38:05 INFO - Successfully installed blobuploader requests docopt 05:38:05 INFO - Cleaning up... 05:38:05 INFO - Return code: 0 05:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:05 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 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:38:05 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 05:38:05 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 05:38:05 INFO - Using env: {'DISPLAY': ':0', 05:38:05 INFO - 'HOME': '/home/cltbld', 05:38:05 INFO - 'LANG': 'en_US.UTF-8', 05:38:05 INFO - 'LANGUAGE': 'en_US:en', 05:38:05 INFO - 'LOGNAME': 'cltbld', 05:38:05 INFO - 'MAIL': '/var/mail/cltbld', 05:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:05 INFO - 'MOZ_NO_REMOTE': '1', 05:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:05 INFO - 'NO_EM_RESTART': '1', 05:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:05 INFO - 'PWD': '/builds/slave/test', 05:38:05 INFO - 'SHELL': '/bin/bash', 05:38:05 INFO - 'SHLVL': '1', 05:38:05 INFO - 'TERM': 'linux', 05:38:05 INFO - 'TMOUT': '86400', 05:38:05 INFO - 'USER': 'cltbld', 05:38:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:05 INFO - '_': '/tools/buildbot/bin/python'} 05:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:05 INFO - Running setup.py (path:/tmp/pip-Srenc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:05 INFO - Running setup.py (path:/tmp/pip-Su_Adv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:05 INFO - Running setup.py (path:/tmp/pip-clZcm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:05 INFO - Running setup.py (path:/tmp/pip-81YnHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:05 INFO - Running setup.py (path:/tmp/pip-ZzuuzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:05 INFO - Running setup.py (path:/tmp/pip-bx900W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:06 INFO - Running setup.py (path:/tmp/pip-7KxGa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:06 INFO - Running setup.py (path:/tmp/pip-ugnTDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:06 INFO - Running setup.py (path:/tmp/pip-8dJYqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:06 INFO - Running setup.py (path:/tmp/pip-cp_4Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:06 INFO - Running setup.py (path:/tmp/pip-E2J7jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:06 INFO - Running setup.py (path:/tmp/pip-64KAfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:06 INFO - Running setup.py (path:/tmp/pip-raOfhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:06 INFO - Running setup.py (path:/tmp/pip-tpzM4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:06 INFO - Running setup.py (path:/tmp/pip-efC3S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:06 INFO - Running setup.py (path:/tmp/pip-3EFgEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:06 INFO - Running setup.py (path:/tmp/pip-mywqto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:06 INFO - Running setup.py install for manifestparser 05:38:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Running setup.py install for mozcrash 05:38:07 INFO - Running setup.py install for mozdebug 05:38:07 INFO - Running setup.py install for mozdevice 05:38:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Running setup.py install for mozfile 05:38:07 INFO - Running setup.py install for mozhttpd 05:38:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Running setup.py install for mozinfo 05:38:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Running setup.py install for mozInstall 05:38:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Running setup.py install for mozleak 05:38:07 INFO - Running setup.py install for mozlog 05:38:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Running setup.py install for moznetwork 05:38:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:07 INFO - Running setup.py install for mozprocess 05:38:08 INFO - Running setup.py install for mozprofile 05:38:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:08 INFO - Running setup.py install for mozrunner 05:38:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:08 INFO - Running setup.py install for mozscreenshot 05:38:08 INFO - Running setup.py install for moztest 05:38:08 INFO - Running setup.py install for mozversion 05:38:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:08 INFO - Cleaning up... 05:38:08 INFO - Return code: 0 05:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 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 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:38:08 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 05:38:08 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 05:38:08 INFO - Using env: {'DISPLAY': ':0', 05:38:08 INFO - 'HOME': '/home/cltbld', 05:38:08 INFO - 'LANG': 'en_US.UTF-8', 05:38:08 INFO - 'LANGUAGE': 'en_US:en', 05:38:08 INFO - 'LOGNAME': 'cltbld', 05:38:08 INFO - 'MAIL': '/var/mail/cltbld', 05:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:08 INFO - 'MOZ_NO_REMOTE': '1', 05:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:08 INFO - 'NO_EM_RESTART': '1', 05:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:08 INFO - 'PWD': '/builds/slave/test', 05:38:08 INFO - 'SHELL': '/bin/bash', 05:38:08 INFO - 'SHLVL': '1', 05:38:08 INFO - 'TERM': 'linux', 05:38:08 INFO - 'TMOUT': '86400', 05:38:08 INFO - 'USER': 'cltbld', 05:38:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:08 INFO - '_': '/tools/buildbot/bin/python'} 05:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:08 INFO - Running setup.py (path:/tmp/pip-npN3BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:08 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)) 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:08 INFO - Running setup.py (path:/tmp/pip-pWml5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:09 INFO - Running setup.py (path:/tmp/pip-GIoqiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:09 INFO - Running setup.py (path:/tmp/pip-qay2Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:09 INFO - Running setup.py (path:/tmp/pip-SQxxfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:09 INFO - Running setup.py (path:/tmp/pip-ipragj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:09 INFO - Running setup.py (path:/tmp/pip-K1xcYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:09 INFO - Running setup.py (path:/tmp/pip-b6zbyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:09 INFO - Running setup.py (path:/tmp/pip-IETkwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:09 INFO - Running setup.py (path:/tmp/pip-NBoUiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:09 INFO - Running setup.py (path:/tmp/pip-dU3v70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:09 INFO - Running setup.py (path:/tmp/pip-9OuyJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:09 INFO - Running setup.py (path:/tmp/pip-h_CZc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:09 INFO - Running setup.py (path:/tmp/pip-v2mMiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:09 INFO - Running setup.py (path:/tmp/pip-6h7bEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:09 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)) 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:09 INFO - Running setup.py (path:/tmp/pip-rcNbb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:10 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)) 05:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:10 INFO - Running setup.py (path:/tmp/pip-djAUkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:10 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)) 05:38:10 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)) 05:38:10 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)) 05:38:10 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)) 05:38:10 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)) 05:38:10 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)) 05:38:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:10 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 05:38:10 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 05:38:10 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 05:38:10 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 05:38:10 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 05:38:10 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 05:38:11 INFO - Downloading blessings-1.6.tar.gz 05:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:12 INFO - Installing collected packages: blessings 05:38:12 INFO - Running setup.py install for blessings 05:38:12 INFO - Successfully installed blessings 05:38:12 INFO - Cleaning up... 05:38:12 INFO - Return code: 0 05:38:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:12 INFO - Reading from file tmpfile_stdout 05:38:12 INFO - Current package versions: 05:38:12 INFO - argparse == 1.2.1 05:38:12 INFO - blessings == 1.6 05:38:12 INFO - blobuploader == 1.2.4 05:38:12 INFO - docopt == 0.6.1 05:38:12 INFO - functools32 == 3.2.3-2 05:38:12 INFO - jsonschema == 2.5.1 05:38:12 INFO - manifestparser == 1.1 05:38:12 INFO - mozInstall == 1.12 05:38:12 INFO - mozcrash == 0.17 05:38:12 INFO - mozdebug == 0.1 05:38:12 INFO - mozdevice == 0.48 05:38:12 INFO - mozfile == 1.2 05:38:12 INFO - mozhttpd == 0.7 05:38:12 INFO - mozinfo == 0.9 05:38:12 INFO - mozleak == 0.1 05:38:12 INFO - mozlog == 3.3 05:38:12 INFO - moznetwork == 0.27 05:38:12 INFO - mozprocess == 0.23 05:38:12 INFO - mozprofile == 0.28 05:38:12 INFO - mozrunner == 6.12 05:38:12 INFO - mozscreenshot == 0.1 05:38:12 INFO - mozsystemmonitor == 0.3 05:38:12 INFO - moztest == 0.7 05:38:12 INFO - mozversion == 1.4 05:38:12 INFO - psutil == 3.1.1 05:38:12 INFO - requests == 1.2.3 05:38:12 INFO - wsgiref == 0.1.2 05:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:12 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')]} 05:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:12 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')]} 05:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:12 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 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:38:12 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 05:38:12 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 05:38:12 INFO - Using env: {'DISPLAY': ':0', 05:38:12 INFO - 'HOME': '/home/cltbld', 05:38:12 INFO - 'LANG': 'en_US.UTF-8', 05:38:12 INFO - 'LANGUAGE': 'en_US:en', 05:38:12 INFO - 'LOGNAME': 'cltbld', 05:38:12 INFO - 'MAIL': '/var/mail/cltbld', 05:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:12 INFO - 'MOZ_NO_REMOTE': '1', 05:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:12 INFO - 'NO_EM_RESTART': '1', 05:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:12 INFO - 'PWD': '/builds/slave/test', 05:38:12 INFO - 'SHELL': '/bin/bash', 05:38:12 INFO - 'SHLVL': '1', 05:38:12 INFO - 'TERM': 'linux', 05:38:12 INFO - 'TMOUT': '86400', 05:38:12 INFO - 'USER': 'cltbld', 05:38:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:12 INFO - '_': '/tools/buildbot/bin/python'} 05:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 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)) 05:38:12 INFO - Cleaning up... 05:38:12 INFO - Return code: 0 05:38:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38:12 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')]} 05:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:12 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')]} 05:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:12 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 0x7f3c6ff17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, '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': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', '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 05:38:12 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 05:38:12 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 05:38:12 INFO - Using env: {'DISPLAY': ':0', 05:38:12 INFO - 'HOME': '/home/cltbld', 05:38:12 INFO - 'LANG': 'en_US.UTF-8', 05:38:12 INFO - 'LANGUAGE': 'en_US:en', 05:38:12 INFO - 'LOGNAME': 'cltbld', 05:38:12 INFO - 'MAIL': '/var/mail/cltbld', 05:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:12 INFO - 'MOZ_NO_REMOTE': '1', 05:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:12 INFO - 'NO_EM_RESTART': '1', 05:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:12 INFO - 'PWD': '/builds/slave/test', 05:38:12 INFO - 'SHELL': '/bin/bash', 05:38:12 INFO - 'SHLVL': '1', 05:38:12 INFO - 'TERM': 'linux', 05:38:12 INFO - 'TMOUT': '86400', 05:38:12 INFO - 'USER': 'cltbld', 05:38:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:12 INFO - '_': '/tools/buildbot/bin/python'} 05:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:38:12 INFO - Cleaning up... 05:38:12 INFO - Return code: 0 05:38:12 INFO - Running post-action listener: _resource_record_post_action 05:38:12 INFO - Running post-action listener: _start_resource_monitoring 05:38:12 INFO - Starting resource monitoring. 05:38:12 INFO - [mozharness: 2016-08-16 12:38:12.931052Z] Finished create-virtualenv step (success) 05:38:12 INFO - [mozharness: 2016-08-16 12:38:12.931564Z] Running install step. 05:38:12 INFO - Running pre-action listener: _resource_record_pre_action 05:38:12 INFO - Running main action method: install 05:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:13 INFO - Reading from file tmpfile_stdout 05:38:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:13 INFO - Reading from file tmpfile_stdout 05:38:13 INFO - Output received: 05:38:13 INFO - Usage: mozinstall [options] installer 05:38:13 INFO - Options: 05:38:13 INFO - -h, --help show this help message and exit 05:38:13 INFO - -d DEST, --destination=DEST 05:38:13 INFO - Directory to install application into. [default: 05:38:13 INFO - "/builds/slave/test"] 05:38:13 INFO - --app=APP Application being installed. [default: firefox] 05:38:13 INFO - mkdir: /builds/slave/test/build/application 05:38:13 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'] 05:38:13 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 05:38:29 INFO - Reading from file tmpfile_stdout 05:38:29 INFO - Output received: 05:38:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:38:29 INFO - Running post-action listener: _resource_record_post_action 05:38:29 INFO - [mozharness: 2016-08-16 12:38:29.264716Z] Finished install step (success) 05:38:29 INFO - [mozharness: 2016-08-16 12:38:29.264965Z] Running run-tests step. 05:38:29 INFO - Running pre-action listener: _resource_record_pre_action 05:38:29 INFO - Running main action method: run_tests 05:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:29 INFO - Python 2.7.3 05:38:29 INFO - Return code: 0 05:38:29 INFO - grabbing minidump binary from tooltool 05:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:29 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 0x2adf090>, '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 0x2ae29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae2e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:29 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 05:38:29 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 05:38:29 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 05:38:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:29 INFO - Return code: 0 05:38:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:38:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:38:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:29 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/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:38:29 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/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 05:38:29 INFO - Using env: {'DISPLAY': ':0', 05:38:29 INFO - 'HOME': '/home/cltbld', 05:38:29 INFO - 'LANG': 'en_US.UTF-8', 05:38:29 INFO - 'LANGUAGE': 'en_US:en', 05:38:29 INFO - 'LOGNAME': 'cltbld', 05:38:29 INFO - 'MAIL': '/var/mail/cltbld', 05:38:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:29 INFO - 'MOZ_NO_REMOTE': '1', 05:38:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:29 INFO - 'NO_EM_RESTART': '1', 05:38:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:29 INFO - 'PWD': '/builds/slave/test', 05:38:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:29 INFO - 'SHELL': '/bin/bash', 05:38:29 INFO - 'SHLVL': '1', 05:38:29 INFO - 'TERM': 'linux', 05:38:29 INFO - 'TMOUT': '86400', 05:38:29 INFO - 'USER': 'cltbld', 05:38:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667', 05:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:29 INFO - '_': '/tools/buildbot/bin/python'} 05:38:29 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/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:38:29 INFO - mozversion application_buildid: 20160816043224 05:38:29 INFO - mozversion application_changeset: dd8193695d2d56667f22a32b77adc243a034cfd2 05:38:29 INFO - mozversion application_display_name: Nightly 05:38:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:29 INFO - mozversion application_name: Firefox 05:38:29 INFO - mozversion application_remotingname: firefox 05:38:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:38:29 INFO - mozversion application_vendor: Mozilla 05:38:29 INFO - mozversion application_version: 51.0a1 05:38:29 INFO - mozversion platform_buildid: 20160816043224 05:38:29 INFO - mozversion platform_changeset: dd8193695d2d56667f22a32b77adc243a034cfd2 05:38:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:38:29 INFO - mozversion platform_version: 51.0a1 05:38:29 INFO - using testdate: 1471351109 05:38:29 INFO - actual date: 1471351109 05:38:29 INFO - starting webserver on 'localhost:54397' 05:38:29 INFO - SUITE-START | Running 2 tests 05:38:29 INFO - TEST-START | dromaeo_css 05:38:29 INFO - operating with platform_type : linux_ 05:38:29 INFO - Initialising browser for dromaeo_css test... 05:38:29 INFO - TEST-INFO | started process 5624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcD15D/profile http://localhost:54397/getInfo.html) 05:38:34 INFO - PROCESS | 5624 | __metrics Screen width/height:1600/1200 05:38:34 INFO - PROCESS | 5624 | colorDepth:24 05:38:34 INFO - PROCESS | 5624 | Browser inner width/height: 1024/697 05:38:34 INFO - PROCESS | 5624 | __metrics 05:38:35 INFO - PROCESS | 5624 | 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" 05:38:35 INFO - PROCESS | 5624 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:35 INFO - PROCESS | 5624 | console.error: PushService: 05:38:35 INFO - PROCESS | 5624 | stateChangeProcessEnqueue: Error transitioning state 05:38:35 INFO - PROCESS | 5624 | UnknownError 05:38:36 INFO - TEST-INFO | 5624: exit 0 05:38:36 INFO - Browser initialized. 05:38:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:36 INFO - TEST-INFO | started process 5709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcD15D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:48 INFO - PROCESS | 5709 | RSS: Main: 157020160 05:38:48 INFO - PROCESS | 5709 | 05:39:39 INFO - PROCESS | 5709 | 1471351179636 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] 05:41:52 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:54397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54397/tests/dromaeo/cssquery-ext.html) 05:41:53 INFO - PROCESS | 5709 | RSS: Main: 245702656 05:41:53 INFO - PROCESS | 5709 | 05:44:56 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:54397/tests/dromaeo/cssquery-ext.html (next: http://localhost:54397/tests/dromaeo/cssquery-jquery.html) 05:44:57 INFO - PROCESS | 5709 | RSS: Main: 246788096 05:44:57 INFO - PROCESS | 5709 | 05:47:59 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:54397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54397/tests/dromaeo/cssquery-mootools.html) 05:48:00 INFO - PROCESS | 5709 | RSS: Main: 219262976 05:48:00 INFO - PROCESS | 5709 | 05:51:02 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:54397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54397/tests/dromaeo/cssquery-prototype.html) 05:51:02 INFO - PROCESS | 5709 | RSS: Main: 189526016 05:51:02 INFO - PROCESS | 5709 | 05:54:06 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:54397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54397/tests/dromaeo/cssquery-yui.html) 05:54:06 INFO - PROCESS | 5709 | RSS: Main: 188858368 05:54:06 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | Cycle 1(1): loaded http://localhost:54397/tests/dromaeo/cssquery-yui.html (next: http://localhost:54397/tests/dromaeo/cssquery-dojo.html) 05:57:10 INFO - PROCESS | 5709 | RSS: Main: 280506368 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | __start_tp_report 05:57:10 INFO - PROCESS | 5709 | _x_x_mozilla_page_load 05:57:10 INFO - PROCESS | 5709 | _x_x_mozilla_page_load_details 05:57:10 INFO - PROCESS | 5709 | |i|pagename|runs| 05:57:10 INFO - PROCESS | 5709 | |0;dojo.html;2634.4467661791023;2650.0989663514424;2655.5087308847865;2679.4775018871314;2680.088769818263;4696.436427628681;4761.23820188769;4809.038192361524;4852.02959408118;4865.148598995175;4701.717896926179;4786.56920877121;4797.472278049412;4823.445303790065;4887.975560122194;4368.606825385715;4389.4732632084115;4461.353103799947;4515.187266292066;4583.908321833561;4484.2376795944765;4517.954820451786;4535;4539.046800171968;4550.340200670901;4344.73931564104;4347.8043488042795;4349.41282926804;4372.234858899712;4414.646828253732;4337.306031035019;4342.478902531685;4345;4356.586124318184;4459.241928872099;4418.359337895987;4419.337099435078;4421.557844215585;4438.289873620205;4462.308342206963;4680.321353403771;4787.377640906695;4849.199882019498;4887.29134275528;4888.9755551222015;5168.61235407346;5232.7122008289525;5275.920861187047;5277.656952298088;5281.0758117329315;5211.452797456288;5247.47525247476;5287.154055351164;5305.920411193797;5313.814016509404;4762.809487620457;4804.111239420718;4855.878603034952;4930.482299358588;4938.6789858659795;5352.768863161416;5368.409474957752;5397.4062853086125;5402.486763757437;5414.512693857571;5174.456682048406;5180.041692286939;5180.4560521145495;5189.870253243699;5190.584753219733;5028.522290382408;5154.175331946871;5203.297554830049;5273.947260527346;5283.9471605284225;5181.248718935733;5182.818601348935;5214.243934629533;5224.791008359699;5229.398619158769;5115.820946266937;5129.769160387791;5131.897362052813;5161.096808058574;5185.766640501187;4184.790760462026;4214.093969796509;4360.258756011485;4373.081652852873;4408.889777755582;3751.6248375162268;3790.33669107905;3798.164403831153;3825.7704537727827;3890;4458.464984201916;4460.464744230713;4460.955390446054;4491.3487544306545;4505.43682039745;5073.822416215415;5234.712090834964;5242.213667949762;5253.527182553588;5255.605829562798;4324.718893271927;4378.978105109454;4385.057212699221;4388.27593447084;4431.7562534060935;4606.493285738566;4615.30770384445;4616.3306320584;4621.768911554409;4659.091477161988;4866.416030076342;4874.220124779948;4886.560209581155;4939.703617782944;4976.32819569368;5018.799248030038;5071.2139618359215;5084.771185296597;5116.334876466036;5176.197689358156;4832.1543729846435;4848.854534363974;4849.151398505318;4849.4908034655855;4879.609631229422;5071.898562028812;5100.6429549931145;5107.591392688501;5109.9744501277255;5160.870978225425;5030.949690503048;5059.165237735732;5076.18780995039;5082.796688132434;5185.040767458032;4993.201087825931;5000.474950130184;5003.399592048978;5006.224035274538;5058.696478211319;4984.75076246179;5018.598512119095;5020.748962551785;5025.748712564284;5029.597632189343;4831.9275210872565;4863.7324947128245;4950.356453661001;4960.379952505937;5048.545630893237;5084.6440749147205;5097.566706829813;5104.259882316969;5105.668131571436;5153.665011774223;4972.975135124301;4986.102501549756;4987.451380348231;4987.750612469289;4988.80044798204 05:57:10 INFO - PROCESS | 5709 | |1;ext.html;552.2654869024195;554.1300158750763;557.8549577109951;564.8672561947941;568.7383803450414;27781.444371112564;37423.251534969284;38796.80601596995;38901.8054909725;41948.37077443841;39270.21459570807;39570.60429395713;39626;39680.20639587207;39704.80147599265;7149.249328820451;7443.851122977537;7573.886391704129;7586.544807311579;7592.050993625797;9483.478408687519;9719.368241064343;9736.123748862601;10066;10074.34516756412;9763.951180244088;9858.556364963593;9869.457179855106;9873.40759554429;9879.962603926557;9684.661036863712;9723.65967191145;9762.609495620167;9762.90237097627;9764.560594773253;9562.28282878787;9626.470544120071;9627.56675949584;9636.518174091267;9640.75898102546;36826.63173368259;37178.25643487115;37203.62796372056;37238.813805931066;37253.627463725286;3045.851528384284;3167.255694911694;3249.0415327478213;3316.4527852904484;3653.799041052741;28552.143435696962;28852.855735721398;29090.70909290901;29184.27039324034;29193.854030729923;3247.772655914087;3328.883489077895;3369.5393641480982;3385.1029477188563;3405.557277553902;246230;246937;247198;247882;247914;47253.29120063202;52168;52904.47095529072;53299.86800528013;53730.462695372546;55664;56482.7175864118;56568.71715641396;56746;56800.71599642058;13275.535356262484;13414.932925335506;13421.456532498692;13426.932865335611;13429.127106738031;8877.778055548662;9787.265955053399;9816.165625921734;9838.60645574169;9941.801163976825;17383.565410864576;17558.824411755973;17617;17675.73486397705;17679.911600442174;6732.730690772314;6788.389044985975;6938.410235130071;6963.442924566022;7003.618769618354;797.4218691448654;872.437277955715;910;935.3499317973943;983.6213057972732;27315.317117071834;27596.448071038467;28017.57973630397;28082.455464949624;28597.85701071523;910.8815853939078;940.8635747816666;949.6771097826634;980.3921568627496;1030.850526673628;14356.928215358856;14921.104733716013;15094.849051509344;15108.622284442978;15351.61620959485;361619;364436;365505;366167;366215;48108;48739;48748.7562562192;48763;48826.75586622044;974.858645496399;1088.7659153282082;1091.028984204075;1183.1836033137108;1194.940252987347;24904.75095249024;30705;30711.539326909668;31106.533401998535;31700.841495792374;45643.77178114088;46152.53847461483;46252.53747462482;46254.7687261575;46288.768556157;265430;265955;266907;267088;267963;20717.378478645664;21002.264920727703;25173.87413062923;25262.494750104528;26522.469550608494;40932;40980.3852942212;41136.79431602823;41411.79294103631;42296;34795.30409391849;35153.47269791007;36352.63647363493;36499.45250821186;37232;33328.50007249845;35401.291974160886;35708.821455892554;35738.28523429569;36308.63691363052;34948.30103397867;35131.824340878135;35704;36122.819385902905;36243;30112.397752045275;32692;32906;33084;33308.500372493945;24530.14144504934;24926.37684057913;25158.74841251564;25405.61891571591;25533.3616659585 05:57:10 INFO - PROCESS | 5709 | |2;jquery.html;365.61245080214974;372.46737165852835;373.2721193672339;380.0821017243354;388.2991200882408;15621.218939053044;16548;16857.072860992655;16867.07231102289;16932.915335423306;14891.925540372311;15340.232988350594;15560.45538406156;15625.531234062968;15669.843301566982;4768.761561921908;4982.701037937717;4987.451380348159;4988.55103040728;4991.475895031024;3690.280395322913;3809.447630093635;4928.383952005999;5614.9719251403685;5842.47417732404;5935.10973353996;5941.168236446901;5941.673207973559;5941.910871336933;5945.37573554777;5630.831075067755;5883.735231914574;5912.763489460416;5918.526517878559;5920.585559010871;5017.84946451607;5185.818496352647;5186.170212765977;5188.92216616751;5192.480751924777;19734;19978.500537486678;20010.69983950242;20011.099500522512;20047.599048019103;1829.938024641048;2002.0690378973702;2009.7286866273012;2058.269314393384;2080.989595052015;12642.367881605884;12783.936080319632;12789.360531973458;13007;13469.595912122651;1736.3835838277355;1751.8773685841995;1761.4851227944087;1780.0387790593063;1785.8214178582039;65495;66778.66610666964;67120.6643966782;67425.3257467424;69430.65284673595;9025.729228123168;9150.771230719285;9255.167034966886;9453.90546094544;9554.283428742732;12580.559680411141;12590.748185036247;12604.621861344174;12691.111622186358;12713.491460341484;6262.718177682015;6340.714667839866;6560.8359791005605;6571.835704107436;6574.211094668574;5927.881442371128;5928.851778705481;6098.878022439615;6121.663308518075;6130.7241174146375;5691.03252447085;5845.9707701462075;5858.297004359504;5904.498117659961;5979.19280897082;1562.1798555758319;1653.3634550698068;1672.5985763416936;1720.3118752499101;1735.4099606133975;853.4409961475244;859.6260626627312;867.1501928110487;868.1318681318681;902.7743064233941;16266.268017939221;16283.430079947146;16547.83452165463;16883;17591.472255832345;852.2925971443686;854.9059603443616;891.3092353426017;911.7994041310901;934.2245935873209;9269.933957594829;9950.353227040365;9961.950190249003;9971.202303815677;10107.3430227035;353825;359401;360066;363323;363643;39308.6069139305;39712.80143599321;47845;63689;66568.33431665719;881.4887365328223;891.1623074310128;906.8277027364779;909.0818273543637;935.6491315756591;15314.770278445609;15375.231238438257;16043.197840108181;16146.657510524456;16246.512604621881;38418.231635366574;38780;38874.4168837462;38961.610383896936;39087.41368879526;50179;50265;50729.746351268004;51596.74201628968;53288.73355633197;6242.375762423721;7511.849763004819;7512.107838482115;7736.226377362219;7779.844403112019;8268.793280168044;10997.395143267197;11249.818769029134;11486.253393529729;11877.14595730158;9787.853182202414;10733;10795;10800.135989120694;10800.24398292112;10084.798304033731;10232.59069637206;10373.118284945864;10635.042846143884;10939.726506837393;10307.278490505592;10620.150387969099;10646.20153488476;10660.360378377321;10984.890151098387;7546.471746977659;7719.263165787877;7914.089879663912;7918.9208107920485;7991.200879911962;9670.468124252951;9981.401115933068;10039.381884333288;10522.31604945676;10665.626703065356 05:57:10 INFO - PROCESS | 5709 | |3;mootools.html;1347.4812197304036;1398.0982266438148;1447.8262608486978;1612.065002298667;1672.6320209553894;7378.667959941802;7956.085050219226;7975.92024079759;7986.4010199235;8000.439969202158;6709.362610552002;6905.447564194865;6912.861742765142;7057.64711764411;7838.8040298992555;1898.3545594497903;2142.635751922177;2216.6896634471186;2225.2322948582714;2238.0935721033006;2156.3423155937435;2202.2072054060604;2207.7350717913873;2214.5460180662926;2227.20934068405;2197.8681279123302;2206.6579680149603;2207.415035015722;2207.4481379655085;2207.8896055197256;2126.2133010786033;2145.3349461666776;2158.2230397057047;2160.7083043789044;2163.350994701583;2086.1863873089505;2109.166879082754;2111;2119.703241546185;2121.363590922717;7712.267334603203;7900.683972641087;7922.4850384724805;7932.881006784845;7939.0870049944415;4349.456317960255;4486.416765820422;4487.640988720895;4488.371627972087;4489.528599497071;2860.6424196975377;2957.406750797791;3019.4866872631706;3032.9545056824163;3051.923701907448;935.1396715022196;952.1002652493396;977.0669011094387;991.9107280344731;999.6101520407047;10280.74298142545;10285.228607854366;10323.122534584569;10324.225683073724;10371.79256414875;3952.4664170336637;4058.411530328145;4258.42511260982;4271.594198551133;4293.0769884474985;8853.468791872509;8916.242119419921;8927.598258078273;8931.240844528158;8938.37431379797;4482.394876691605;4483.865484035484;4484.0583477469445;4487.349334346567;4497.235469970113;3550.3609350316674;4070.8575199868455;4078.4290199372113;4082.101937573729;4084.8366065357645;3324.16895776056;3518.472229165646;3539.628339024417;3656.433252845813;3683.189698266377;1173.2901594535354;1192.9880701192876;1203.0676225924803;1211.9757604847853;1234.672811704899;744.9404047676173;845.0788640381891;846.1115828380299;847.2798121596594;862.2326129744532;5134.871628209325;5254.579633629301;5255.789768409298;5266.526012658879;5273.630845840831;831.4678605692362;866.5840396609536;907.0339988238555;915.995420022909;959.1463597398321;3350.480675495302;3479.3215323012278;3483.54713887193;3490.2321489272317;3602.351576716164;9528.380655257386;9714.417134971784;9775.755606109904;9794.510274486247;9803;9731.172850307661;9752.21982241419;9753.853692194623;9757.073078057572;9766.56050477716;6679.666016699146;6947.305269473012;6956.826079347956;7145.714171433188;7209.459290553124;5093.108705976513;5099.77051032697;5129.8717532062;5182.32629758129;5354.437784032621;8678.956605216934;8843.159899809507;8864.113588641085;8922.464652120894;9004.099590041205;8989.146031127033;9004.639814407612;9025.864612030693;9142.725718228463;9170.908290917005;6589.4069533742195;6827.21487028998;6957.686904089227;6957.8956315654295;6984.685689143899;7413.629318534159;7600.087989441303;7688.692452301845;7696.961515192388;7702.537847729154;6800.693968771318;6851.315586169717;6856.348646878539;7027.543209691354;7083.433325333858;6562.179727534059;6642.568233064835;6704.128463299739;6876.037354770437;6917.308269173042;6444.194475690539;6560.8359791005605;6564.737410503526;6567.2447668518735;6569.277379488348;4331.285337919208;4346.934795978126;4432.556744325541;4465.709728867613;4488.192125417456;4465.910681786281;4476.149531589118;4620.306953956933;4694.882627934329;4859.2954021665955 05:57:10 INFO - PROCESS | 5709 | |4;prototype.html;302.9121554749123;306.0619202145424;310.3188501239779;311.62293624714096;314.2097624474446;4889.9266511002315;4917.385326834145;4921.360223170992;4934;4956.925646115306;4774.880627984302;4858.9514104858945;4863.489333619963;4866.513348665132;4870.732109733964;3617.891463256093;3756.9060773480746;3765.9246815063684;3786.2616789726017;3814.7138964577766;3824.8470061197518;3830.8276127574327;3837.2133712588993;3838.2323535292912;3839.9072505484437;3801.3157631626295;3804;3808.257389808988;3825.885223443287;3828.923421531568;3591.551056117972;3654.2326111516613;3795.35478968576;3804.1060350817534;3828.693704503633;3352.6479719629333;3354.37943980362;3355.8825441109443;3365.3605814895336;3366.1921138926728;4650.697704649187;4663.114008338405;4672.929906051378;4676.152919596774;4687.859364219079;4164.729292595972;4338.045629961435;4338.739675619441;4346.826126954918;4366.214081465335;4979.7261150636705;4998.57512111471;5003.349564556621;5004.199328107522;5033.672811267293;3676.3382591133586;3678.668919797231;3682.342945674457;3691.427828686558;3719.702423806089;5147.176451767737;5357;5374.167004114369;5385.2999110115825;5387.326584176978;3724.925501489955;3768.6419790119894;3773.8867833965023;3773.9433908491396;3776.5090538229856;3806.3148633246283;3808.27642747877;3815.523059617548;3815.73289869712;3822.7515211511163;4329.675274354436;4334.436523251957;4349.978250108792;4352.216601011848;4357.934630980538;4794.184988551885;5073.518015788494;5089.949100509021;5103.413107492612;5106.259592359162;1285.8842704156484;1286.5239861251398;1292.8642492538147;1297.3902265934996;1298.6104168749525;792.4769652029748;822.6257053040972;828.9212524810133;843.8227972125923;844.9915500845036;4333.913321733611;4388.890277743082;4477.529859364785;4496.348029535699;4497.460304763449;5243.580513558906;5251.868703282448;5253.973730131325;5254.108520932461;5262.842114736564;4459.710118842265;4475.082608065339;4478.462584489882;4496.808345788369;4509.241395855619;2629.8553579552927;2781.304673831542;2785.7046473389564;2787.9442411152068;2801.3976994946183;4947.455779864212;4950.9009819803405;4953.2570114483115;4981.427135879348;4988.775505102279;5235.947640523622;5389.164679474688;5389.541888939484;5392.811251606175;5417.972910135424;4982.999999999927;4989.276554899592;5005.224190250517;5010.67430617016;5016.247562865527;5267.657602255841;5275.815346462856;5280.947190528045;5286.709230992333;5295.470452954673;5014.598832093351;5150.742462876916;5169.121249387688;5186.447283610588;5200.947990520046;4931.926021109614;4953.504649535162;4958.6281028923695;4967.7516124192925;4973.875653108701;3358.3954888120375;3374.0477082552766;3385.898423047214;3410.2326976431095;3410.9829450852585;4666.34671146033;4685.718856868599;4707.29390591414;4707.529247075265;4944.629152813625;5073.974630126973;5090.796368145381;5100.285959965682;5103.622022054099;5126.6923984561045;5089.440161582149;5102.770375333044;5106.795728170831;5161.838586318048;5177.275181474522;4843.588294994824;5045.722485263345;5051.368578927634;5058.1654027085115;5076.213186956028;4902;4965.1807451770055;5093.1341671915125;5126.53861152498;5144.871378215425;4975.900481990412;5004.949950500594;5007.5993920487;5015;5039.571636410946 05:57:10 INFO - PROCESS | 5709 | |5;yui.html;614.1678026274395;629.3643420145652;658.2298710508704;680.0003994128629;736.8231624410141;12445.751084978296;13119.212847229173;13252.337383130853;13267.336633168352;13276.269805160724;13395.464181432731;13478.5282515112;13498.865011349908;13528.120672156303;13531.25578093207;619.9628022318675;734.8052766016983;746.3879618712672;762.3634265388407;766.1993217088157;764.1556080531017;770.3721467004401;770.9421793365492;774.0363247756551;775.0389516998908;817.0889458254034;817.1909809288791;818.0960039156736;818.5007145641155;820.5199958024533;654.3816093791321;787.1262898183012;806.5443024691031;813.9674413023472;814.7474282972297;585.3005658238407;590.5895402695129;592.6858764854634;592.8814237152544;593.8129489210885;11929;11957.282563046245;11960.64118076459;11962.282263064244;11976.401179940967;12427.689307767288;12728.936355318165;12942.891425284844;13068.803967940488;13407.262600556965;11731.53073877044;11844.40777961107;11848.111391645574;11926.224795388272;12076;4048.1296521247777;4076.0625056236936;4129.772862492562;4174.269502836992;4177.248095342837;62785;62788;62931;62969.68515157395;63053.684731576504;9993.050660187271;10033.397996120257;10228.386296822215;10896.891031089588;10911.945440272748;19734.70397944032;19745.802541974397;19753.703694444594;19761.802381976282;19767.406977790688;6940.9652951734915;6989.790306290819;7061.89407158893;7069.575825450489;7101.822454438577;3623.239119784822;3639.29033838399;3697.131174174067;3720.069982504374;3774.094217387807;2850.5866649336144;2954.9409011819644;2963.9259018524276;2963.925901852471;2965.154930844699;489.21236808737905;493.2084005171719;540.2650861109374;555.2476394485494;562.8958642651122;571.6198727845936;583.2388732703862;595.119223549141;599.2539288585651;605.59727781026;7563.886541701879;7578.962105189549;7959.8408031839035;8243.83512329762;8320.542370169578;509.0480800902336;529.9629025968145;566.5552541255095;590.8404730722767;609.1897775957965;3602.1174812171184;3815.7999363867616;3931.9803400983383;3947.9013024674036;3976.204759048202;99378;107331;108751.77475153485;111228;111335.88664113256;68067.31932680709;68329;70859.64570177117;84937.57531212304;85768.57115714382;70702.64648676723;70705;71021;72607;73898.26101738914;7404.851902962018;7572.583507907118;7709.612269791492;7751.302382785577;7793.37652987771;43068.35397468978;43358.56641433672;43792;44372;44876.77561612171;35133.472997904544;37504;39196.216075678894;58002.709986449794;64104.35895641171;10096.646617368357;10234.283600148216;10249;10374.844377334497;10707.357558546511;11951.37913979255;12078.758424831278;12611.30637814929;12749.426275817796;13090.280034598189;10307.587696492057;10914.126869850234;11247;11501.367424791717;11575.42122893835;10687.5190616424;11203.271787333797;11483.655490335303;11786.882131178578;11815;10822.188335874684;11530.365829879438;11650.30098194111;11656.766864662828;11671.76656466883;7985.960070199611;8078.596070196584;8271.090180080308;8365.414420990472;8540.27407670355;8487.908715130863;9097.363184577016;9111.407758495676;9145.771355715895;9190.586423611087 05:57:10 INFO - PROCESS | 5709 | __end_tp_report 05:57:10 INFO - PROCESS | 5709 | __start_cc_report 05:57:10 INFO - PROCESS | 5709 | _x_x_mozilla_cycle_collect,1007 05:57:10 INFO - PROCESS | 5709 | __end_cc_report 05:57:10 INFO - PROCESS | 5709 | __startTimestamp1471352230354__endTimestamp 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | ------- Summary: start ------- 05:57:10 INFO - PROCESS | 5709 | Number of tests: 6 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | [#0] dojo.html Cycles:165 Average:4776.82 Median:4888.98 stddev:521.17 (10.7%) stddev-sans-first:494.92 05:57:10 INFO - PROCESS | 5709 | Values: 2634.4 2650.1 2655.5 2679.5 2680.1 4696.4 4761.2 4809.0 4852.0 4865.1 4701.7 4786.6 4797.5 4823.4 4888.0 4368.6 4389.5 4461.4 4515.2 4583.9 4484.2 4518.0 4535.0 4539.0 4550.3 4344.7 4347.8 4349.4 4372.2 4414.6 4337.3 4342.5 4345.0 4356.6 4459.2 4418.4 4419.3 4421.6 4438.3 4462.3 4680.3 4787.4 4849.2 4887.3 4889.0 5168.6 5232.7 5275.9 5277.7 5281.1 5211.5 5247.5 5287.2 5305.9 5313.8 4762.8 4804.1 4855.9 4930.5 4938.7 5352.8 5368.4 5397.4 5402.5 5414.5 5174.5 5180.0 5180.5 5189.9 5190.6 5028.5 5154.2 5203.3 5273.9 5283.9 5181.2 5182.8 5214.2 5224.8 5229.4 5115.8 5129.8 5131.9 5161.1 5185.8 4184.8 4214.1 4360.3 4373.1 4408.9 3751.6 3790.3 3798.2 3825.8 3890.0 4458.5 4460.5 4461.0 4491.3 4505.4 5073.8 5234.7 5242.2 5253.5 5255.6 4324.7 4379.0 4385.1 4388.3 4431.8 4606.5 4615.3 4616.3 4621.8 4659.1 4866.4 4874.2 4886.6 4939.7 4976.3 5018.8 5071.2 5084.8 5116.3 5176.2 4832.2 4848.9 4849.2 4849.5 4879.6 5071.9 5100.6 5107.6 5110.0 5160.9 5030.9 5059.2 5076.2 5082.8 5185.0 4993.2 5000.5 5003.4 5006.2 5058.7 4984.8 5018.6 5020.7 5025.7 5029.6 4831.9 4863.7 4950.4 4960.4 5048.5 5084.6 5097.6 5104.3 5105.7 5153.7 4973.0 4986.1 4987.5 4987.8 4988.8 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | [#1] ext.html Cycles:180 Average:45301.65 Median:366191.00 stddev:77989.43 (21.3%) stddev-sans-first:78135.84 05:57:10 INFO - PROCESS | 5709 | Values: 552.3 554.1 557.9 564.9 568.7 27781.4 37423.3 38796.8 38901.8 41948.4 39270.2 39570.6 39626.0 39680.2 39704.8 7149.2 7443.9 7573.9 7586.5 7592.1 9483.5 9719.4 9736.1 10066.0 10074.3 9764.0 9858.6 9869.5 9873.4 9880.0 9684.7 9723.7 9762.6 9762.9 9764.6 9562.3 9626.5 9627.6 9636.5 9640.8 36826.6 37178.3 37203.6 37238.8 37253.6 3045.9 3167.3 3249.0 3316.5 3653.8 28552.1 28852.9 29090.7 29184.3 29193.9 3247.8 3328.9 3369.5 3385.1 3405.6 246230.0 246937.0 247198.0 247882.0 247914.0 47253.3 52168.0 52904.5 53299.9 53730.5 55664.0 56482.7 56568.7 56746.0 56800.7 13275.5 13414.9 13421.5 13426.9 13429.1 8877.8 9787.3 9816.2 9838.6 9941.8 17383.6 17558.8 17617.0 17675.7 17679.9 6732.7 6788.4 6938.4 6963.4 7003.6 797.4 872.4 910.0 935.3 983.6 27315.3 27596.4 28017.6 28082.5 28597.9 910.9 940.9 949.7 980.4 1030.9 14356.9 14921.1 15094.8 15108.6 15351.6 361619.0 364436.0 365505.0 366167.0 366215.0 48108.0 48739.0 48748.8 48763.0 48826.8 974.9 1088.8 1091.0 1183.2 1194.9 24904.8 30705.0 30711.5 31106.5 31700.8 45643.8 46152.5 46252.5 46254.8 46288.8 265430.0 265955.0 266907.0 267088.0 267963.0 20717.4 21002.3 25173.9 25262.5 26522.5 40932.0 40980.4 41136.8 41411.8 42296.0 34795.3 35153.5 36352.6 36499.5 37232.0 33328.5 35401.3 35708.8 35738.3 36308.6 34948.3 35131.8 35704.0 36122.8 36243.0 30112.4 32692.0 32906.0 33084.0 33308.5 24530.1 24926.4 25158.7 25405.6 25533.4 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | [#2] jquery.html Cycles:180 Average:22757.21 Median:22240.78 stddev:59168.74 (266.0%) stddev-sans-first:59310.84 05:57:10 INFO - PROCESS | 5709 | Values: 365.6 372.5 373.3 380.1 388.3 15621.2 16548.0 16857.1 16867.1 16932.9 14891.9 15340.2 15560.5 15625.5 15669.8 4768.8 4982.7 4987.5 4988.6 4991.5 3690.3 3809.4 4928.4 5615.0 5842.5 5935.1 5941.2 5941.7 5941.9 5945.4 5630.8 5883.7 5912.8 5918.5 5920.6 5017.8 5185.8 5186.2 5188.9 5192.5 19734.0 19978.5 20010.7 20011.1 20047.6 1829.9 2002.1 2009.7 2058.3 2081.0 12642.4 12783.9 12789.4 13007.0 13469.6 1736.4 1751.9 1761.5 1780.0 1785.8 65495.0 66778.7 67120.7 67425.3 69430.7 9025.7 9150.8 9255.2 9453.9 9554.3 12580.6 12590.7 12604.6 12691.1 12713.5 6262.7 6340.7 6560.8 6571.8 6574.2 5927.9 5928.9 6098.9 6121.7 6130.7 5691.0 5846.0 5858.3 5904.5 5979.2 1562.2 1653.4 1672.6 1720.3 1735.4 853.4 859.6 867.2 868.1 902.8 16266.3 16283.4 16547.8 16883.0 17591.5 852.3 854.9 891.3 911.8 934.2 9269.9 9950.4 9962.0 9971.2 10107.3 353825.0 359401.0 360066.0 363323.0 363643.0 39308.6 39712.8 47845.0 63689.0 66568.3 881.5 891.2 906.8 909.1 935.6 15314.8 15375.2 16043.2 16146.7 16246.5 38418.2 38780.0 38874.4 38961.6 39087.4 50179.0 50265.0 50729.7 51596.7 53288.7 6242.4 7511.8 7512.1 7736.2 7779.8 8268.8 10997.4 11249.8 11486.3 11877.1 9787.9 10733.0 10795.0 10800.1 10800.2 10084.8 10232.6 10373.1 10635.0 10939.7 10307.3 10620.2 10646.2 10660.4 10984.9 7546.5 7719.3 7914.1 7918.9 7991.2 9670.5 9981.4 10039.4 10522.3 10665.6 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | [#3] mootools.html Cycles:180 Average:5107.98 Median:5255.18 stddev:2861.10 (54.4%) stddev-sans-first:2855.17 05:57:10 INFO - PROCESS | 5709 | Values: 1347.5 1398.1 1447.8 1612.1 1672.6 7378.7 7956.1 7975.9 7986.4 8000.4 6709.4 6905.4 6912.9 7057.6 7838.8 1898.4 2142.6 2216.7 2225.2 2238.1 2156.3 2202.2 2207.7 2214.5 2227.2 2197.9 2206.7 2207.4 2207.4 2207.9 2126.2 2145.3 2158.2 2160.7 2163.4 2086.2 2109.2 2111.0 2119.7 2121.4 7712.3 7900.7 7922.5 7932.9 7939.1 4349.5 4486.4 4487.6 4488.4 4489.5 2860.6 2957.4 3019.5 3033.0 3051.9 935.1 952.1 977.1 991.9 999.6 10280.7 10285.2 10323.1 10324.2 10371.8 3952.5 4058.4 4258.4 4271.6 4293.1 8853.5 8916.2 8927.6 8931.2 8938.4 4482.4 4483.9 4484.1 4487.3 4497.2 3550.4 4070.9 4078.4 4082.1 4084.8 3324.2 3518.5 3539.6 3656.4 3683.2 1173.3 1193.0 1203.1 1212.0 1234.7 744.9 845.1 846.1 847.3 862.2 5134.9 5254.6 5255.8 5266.5 5273.6 831.5 866.6 907.0 916.0 959.1 3350.5 3479.3 3483.5 3490.2 3602.4 9528.4 9714.4 9775.8 9794.5 9803.0 9731.2 9752.2 9753.9 9757.1 9766.6 6679.7 6947.3 6956.8 7145.7 7209.5 5093.1 5099.8 5129.9 5182.3 5354.4 8679.0 8843.2 8864.1 8922.5 9004.1 8989.1 9004.6 9025.9 9142.7 9170.9 6589.4 6827.2 6957.7 6957.9 6984.7 7413.6 7600.1 7688.7 7697.0 7702.5 6800.7 6851.3 6856.3 7027.5 7083.4 6562.2 6642.6 6704.1 6876.0 6917.3 6444.2 6560.8 6564.7 6567.2 6569.3 4331.3 4346.9 4432.6 4465.7 4488.2 4465.9 4476.1 4620.3 4694.9 4859.3 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | [#4] prototype.html Cycles:180 Average:4214.51 Median:4818.89 stddev:1229.18 (25.5%) stddev-sans-first:1197.05 05:57:10 INFO - PROCESS | 5709 | Values: 302.9 306.1 310.3 311.6 314.2 4889.9 4917.4 4921.4 4934.0 4956.9 4774.9 4859.0 4863.5 4866.5 4870.7 3617.9 3756.9 3765.9 3786.3 3814.7 3824.8 3830.8 3837.2 3838.2 3839.9 3801.3 3804.0 3808.3 3825.9 3828.9 3591.6 3654.2 3795.4 3804.1 3828.7 3352.6 3354.4 3355.9 3365.4 3366.2 4650.7 4663.1 4672.9 4676.2 4687.9 4164.7 4338.0 4338.7 4346.8 4366.2 4979.7 4998.6 5003.3 5004.2 5033.7 3676.3 3678.7 3682.3 3691.4 3719.7 5147.2 5357.0 5374.2 5385.3 5387.3 3724.9 3768.6 3773.9 3773.9 3776.5 3806.3 3808.3 3815.5 3815.7 3822.8 4329.7 4334.4 4350.0 4352.2 4357.9 4794.2 5073.5 5089.9 5103.4 5106.3 1285.9 1286.5 1292.9 1297.4 1298.6 792.5 822.6 828.9 843.8 845.0 4333.9 4388.9 4477.5 4496.3 4497.5 5243.6 5251.9 5254.0 5254.1 5262.8 4459.7 4475.1 4478.5 4496.8 4509.2 2629.9 2781.3 2785.7 2787.9 2801.4 4947.5 4950.9 4953.3 4981.4 4988.8 5235.9 5389.2 5389.5 5392.8 5418.0 4983.0 4989.3 5005.2 5010.7 5016.2 5267.7 5275.8 5280.9 5286.7 5295.5 5014.6 5150.7 5169.1 5186.4 5200.9 4931.9 4953.5 4958.6 4967.8 4973.9 3358.4 3374.0 3385.9 3410.2 3411.0 4666.3 4685.7 4707.3 4707.5 4944.6 5074.0 5090.8 5100.3 5103.6 5126.7 5089.4 5102.8 5106.8 5161.8 5177.3 4843.6 5045.7 5051.4 5058.2 5076.2 4902.0 4965.2 5093.1 5126.5 5144.9 4975.9 5004.9 5007.6 5015.0 5039.6 05:57:10 INFO - PROCESS | 5709 | 05:57:10 INFO - PROCESS | 5709 | [#5] yui.html Cycles:180 Average:17204.21 Median:22682.99 stddev:25025.32 (110.3%) stddev-sans-first:25064.52 05:57:10 INFO - PROCESS | 5709 | Values: 614.2 629.4 658.2 680.0 736.8 12445.8 13119.2 13252.3 13267.3 13276.3 13395.5 13478.5 13498.9 13528.1 13531.3 620.0 734.8 746.4 762.4 766.2 764.2 770.4 770.9 774.0 775.0 817.1 817.2 818.1 818.5 820.5 654.4 787.1 806.5 814.0 814.7 585.3 590.6 592.7 592.9 593.8 11929.0 11957.3 11960.6 11962.3 11976.4 12427.7 12728.9 12942.9 13068.8 13407.3 11731.5 11844.4 11848.1 11926.2 12076.0 4048.1 4076.1 4129.8 4174.3 4177.2 62785.0 62788.0 62931.0 62969.7 63053.7 9993.1 10033.4 10228.4 10896.9 10911.9 19734.7 19745.8 19753.7 19761.8 19767.4 6941.0 6989.8 7061.9 7069.6 7101.8 3623.2 3639.3 3697.1 3720.1 3774.1 2850.6 2954.9 2963.9 2963.9 2965.2 489.2 493.2 540.3 555.2 562.9 571.6 583.2 595.1 599.3 605.6 7563.9 7579.0 7959.8 8243.8 8320.5 509.0 530.0 566.6 590.8 609.2 3602.1 3815.8 3932.0 3947.9 3976.2 99378.0 107331.0 108751.8 111228.0 111335.9 68067.3 68329.0 70859.6 84937.6 85768.6 70702.6 70705.0 71021.0 72607.0 73898.3 7404.9 7572.6 7709.6 7751.3 7793.4 43068.4 43358.6 43792.0 44372.0 44876.8 35133.5 37504.0 39196.2 58002.7 64104.4 10096.6 10234.3 10249.0 10374.8 10707.4 11951.4 12078.8 12611.3 12749.4 13090.3 10307.6 10914.1 11247.0 11501.4 11575.4 10687.5 11203.3 11483.7 11786.9 11815.0 10822.2 11530.4 11650.3 11656.8 11671.8 7986.0 8078.6 8271.1 8365.4 8540.3 8487.9 9097.4 9111.4 9145.8 9190.6 05:57:10 INFO - PROCESS | 5709 | -------- Summary: end -------- 05:57:10 INFO - PROCESS | 5709 | 05:57:11 INFO - TEST-INFO | 5709: exit 0 05:57:11 INFO - TEST-OK | dromaeo_css | took 1121626ms 05:57:11 INFO - TEST-START | kraken 05:57:11 INFO - operating with platform_type : linux_ 05:57:11 INFO - Initialising browser for kraken test... 05:57:11 INFO - TEST-INFO | started process 6009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu45sJ7/profile http://localhost:54397/getInfo.html) 05:57:16 INFO - PROCESS | 6009 | __metrics Screen width/height:1600/1200 05:57:16 INFO - PROCESS | 6009 | colorDepth:24 05:57:16 INFO - PROCESS | 6009 | Browser inner width/height: 1024/697 05:57:16 INFO - PROCESS | 6009 | __metrics 05:57:16 INFO - PROCESS | 6009 | 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" 05:57:16 INFO - PROCESS | 6009 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:17 INFO - PROCESS | 6009 | console.error: PushService: 05:57:17 INFO - PROCESS | 6009 | stateChangeProcessEnqueue: Error transitioning state 05:57:17 INFO - PROCESS | 6009 | UnknownError 05:57:17 INFO - TEST-INFO | 6009: exit 0 05:57:17 INFO - Browser initialized. 05:57:17 INFO - Running cycle 1/1 for kraken test... 05:57:17 INFO - TEST-INFO | started process 6092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu45sJ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:29 INFO - PROCESS | 6092 | RSS: Main: 157945856 05:57:29 INFO - PROCESS | 6092 | 05:57:32 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54397/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:33 INFO - PROCESS | 6092 | RSS: Main: 204931072 05:57:33 INFO - PROCESS | 6092 | 05:57:35 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54397/tests/kraken/driver.html?testName=audio-dft) 05:57:36 INFO - PROCESS | 6092 | RSS: Main: 196227072 05:57:36 INFO - PROCESS | 6092 | 05:57:39 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54397/tests/kraken/driver.html?testName=audio-fft) 05:57:40 INFO - PROCESS | 6092 | RSS: Main: 277553152 05:57:40 INFO - PROCESS | 6092 | 05:57:42 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54397/tests/kraken/driver.html?testName=audio-oscillator) 05:57:43 INFO - PROCESS | 6092 | RSS: Main: 188899328 05:57:43 INFO - PROCESS | 6092 | 05:57:45 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:46 INFO - PROCESS | 6092 | RSS: Main: 193327104 05:57:46 INFO - PROCESS | 6092 | 05:57:49 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54397/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:49 INFO - PROCESS | 6092 | RSS: Main: 229449728 05:57:49 INFO - PROCESS | 6092 | 05:57:53 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54397/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:54 INFO - PROCESS | 6092 | RSS: Main: 222363648 05:57:54 INFO - PROCESS | 6092 | 05:57:56 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54397/tests/kraken/driver.html?testName=json-parse-financial) 05:57:57 INFO - PROCESS | 6092 | RSS: Main: 225816576 05:57:57 INFO - PROCESS | 6092 | 05:57:59 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:59 INFO - PROCESS | 6092 | RSS: Main: 189001728 05:57:59 INFO - PROCESS | 6092 | 05:58:01 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:58:02 INFO - PROCESS | 6092 | RSS: Main: 196603904 05:58:02 INFO - PROCESS | 6092 | 05:58:04 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:05 INFO - PROCESS | 6092 | RSS: Main: 193519616 05:58:05 INFO - PROCESS | 6092 | 05:58:08 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:08 INFO - PROCESS | 6092 | RSS: Main: 188907520 05:58:08 INFO - PROCESS | 6092 | 05:58:11 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:12 INFO - PROCESS | 6092 | RSS: Main: 192122880 05:58:12 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | Cycle 1(1): loaded http://localhost:54397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54397/tests/kraken/driver.html?testName=ai-astar) 05:58:14 INFO - PROCESS | 6092 | RSS: Main: 242614272 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | __start_tp_report 05:58:14 INFO - PROCESS | 6092 | _x_x_mozilla_page_load 05:58:14 INFO - PROCESS | 6092 | _x_x_mozilla_page_load_details 05:58:14 INFO - PROCESS | 6092 | |i|pagename|runs| 05:58:14 INFO - PROCESS | 6092 | |0;ai-astar;107;117;114;116;110;115;116;115;115;115 05:58:14 INFO - PROCESS | 6092 | |1;audio-beat-detection;151;121;121;188;123;123;149;121;196;127 05:58:14 INFO - PROCESS | 6092 | |2;audio-dft;160;160;162;160;161;161;162;163;162;160 05:58:14 INFO - PROCESS | 6092 | |3;audio-fft;75;76;77;113;77;76;75;76;128;75 05:58:14 INFO - PROCESS | 6092 | |4;audio-oscillator;86;87;143;88;88;86;126;86;86;130 05:58:14 INFO - PROCESS | 6092 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;119;117 05:58:14 INFO - PROCESS | 6092 | |6;imaging-darkroom;146;146;147;146;146;146;147;146;147;146 05:58:14 INFO - PROCESS | 6092 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 05:58:14 INFO - PROCESS | 6092 | |8;json-parse-financial;71;64;67;65;65;68;65;64;67;64 05:58:14 INFO - PROCESS | 6092 | |9;json-stringify-tinderbox;66;66;65;65;66;66;68;66;65;66 05:58:14 INFO - PROCESS | 6092 | |10;stanford-crypto-aes;83;91;83;83;83;83;81;82;81;82 05:58:14 INFO - PROCESS | 6092 | |11;stanford-crypto-ccm;135;133;132;131;131;134;137;147;157;134 05:58:14 INFO - PROCESS | 6092 | |12;stanford-crypto-pbkdf2;179;172;175;175;169;170;173;170;171;179 05:58:14 INFO - PROCESS | 6092 | |13;stanford-crypto-sha256-iterative;69;68;68;67;68;70;67;67;67;66 05:58:14 INFO - PROCESS | 6092 | __end_tp_report 05:58:14 INFO - PROCESS | 6092 | __start_cc_report 05:58:14 INFO - PROCESS | 6092 | _x_x_mozilla_cycle_collect,1965 05:58:14 INFO - PROCESS | 6092 | __end_cc_report 05:58:14 INFO - PROCESS | 6092 | __startTimestamp1471352294269__endTimestamp 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | ------- Summary: start ------- 05:58:14 INFO - PROCESS | 6092 | Number of tests: 14 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.09 (2.7%) stddev-sans-first:1.99 05:58:14 INFO - PROCESS | 6092 | Values: 107.0 117.0 114.0 116.0 110.0 115.0 116.0 115.0 115.0 115.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:138.00 stddev:28.74 (20.8%) stddev-sans-first:30.29 05:58:14 INFO - PROCESS | 6092 | Values: 151.0 121.0 121.0 188.0 123.0 123.0 149.0 121.0 196.0 127.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 05:58:14 INFO - PROCESS | 6092 | Values: 160.0 160.0 162.0 160.0 161.0 161.0 162.0 163.0 162.0 160.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:19.16 (25.2%) stddev-sans-first:19.99 05:58:14 INFO - PROCESS | 6092 | Values: 75.0 76.0 77.0 113.0 77.0 76.0 75.0 76.0 128.0 75.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:86.00 stddev:22.76 (26.5%) stddev-sans-first:23.52 05:58:14 INFO - PROCESS | 6092 | Values: 86.0 87.0 143.0 88.0 88.0 86.0 126.0 86.0 86.0 130.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 05:58:14 INFO - PROCESS | 6092 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 119.0 117.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:58:14 INFO - PROCESS | 6092 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:58:14 INFO - PROCESS | 6092 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:2.26 (3.4%) stddev-sans-first:1.51 05:58:14 INFO - PROCESS | 6092 | Values: 71.0 64.0 67.0 65.0 65.0 68.0 65.0 64.0 67.0 64.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 05:58:14 INFO - PROCESS | 6092 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 68.0 66.0 65.0 66.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.86 (3.4%) stddev-sans-first:3.03 05:58:14 INFO - PROCESS | 6092 | Values: 83.0 91.0 83.0 83.0 83.0 83.0 81.0 82.0 81.0 82.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:134.50 stddev:8.40 (6.2%) stddev-sans-first:8.87 05:58:14 INFO - PROCESS | 6092 | Values: 135.0 133.0 132.0 131.0 131.0 134.0 137.0 147.0 157.0 134.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.00 stddev:3.62 (2.1%) stddev-sans-first:3.20 05:58:14 INFO - PROCESS | 6092 | Values: 179.0 172.0 175.0 175.0 169.0 170.0 173.0 170.0 171.0 179.0 05:58:14 INFO - PROCESS | 6092 | 05:58:14 INFO - PROCESS | 6092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 05:58:14 INFO - PROCESS | 6092 | Values: 69.0 68.0 68.0 67.0 68.0 70.0 67.0 67.0 67.0 66.0 05:58:14 INFO - PROCESS | 6092 | -------- Summary: end -------- 05:58:14 INFO - PROCESS | 6092 | 05:58:15 INFO - TEST-INFO | 6092: exit 0 05:58:15 INFO - TEST-OK | kraken | took 64270ms 05:58:15 INFO - SUITE-END | took 1185s 05:58:15 INFO - Completed test suite (00:19:46) 05:58:15 INFO - javascript benchmark 05:58:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.4467661791023, 2650.0989663514424, 2655.5087308847865, 2679.4775018871314, 2680.088769818263, 4696.436427628681, 4761.23820188769, 4809.038192361524, 4852.02959408118, 4865.148598995175, 4701.717896926179, 4786.56920877121, 4797.472278049412, 4823.445303790065, 4887.975560122194, 4368.606825385715, 4389.4732632084115, 4461.353103799947, 4515.187266292066, 4583.908321833561, 4484.2376795944765, 4517.954820451786, 4535.0, 4539.046800171968, 4550.340200670901, 4344.73931564104, 4347.8043488042795, 4349.41282926804, 4372.234858899712, 4414.646828253732, 4337.306031035019, 4342.478902531685, 4345.0, 4356.586124318184, 4459.241928872099, 4418.359337895987, 4419.337099435078, 4421.557844215585, 4438.289873620205, 4462.308342206963, 4680.321353403771, 4787.377640906695, 4849.199882019498, 4887.29134275528, 4888.9755551222015, 5168.61235407346, 5232.7122008289525, 5275.920861187047, 5277.656952298088, 5281.0758117329315, 5211.452797456288, 5247.47525247476, 5287.154055351164, 5305.920411193797, 5313.814016509404, 4762.809487620457, 4804.111239420718, 4855.878603034952, 4930.482299358588, 4938.6789858659795, 5352.768863161416, 5368.409474957752, 5397.4062853086125, 5402.486763757437, 5414.512693857571, 5174.456682048406, 5180.041692286939, 5180.4560521145495, 5189.870253243699, 5190.584753219733, 5028.522290382408, 5154.175331946871, 5203.297554830049, 5273.947260527346, 5283.9471605284225, 5181.248718935733, 5182.818601348935, 5214.243934629533, 5224.791008359699, 5229.398619158769, 5115.820946266937, 5129.769160387791, 5131.897362052813, 5161.096808058574, 5185.766640501187, 4184.790760462026, 4214.093969796509, 4360.258756011485, 4373.081652852873, 4408.889777755582, 3751.6248375162268, 3790.33669107905, 3798.164403831153, 3825.7704537727827, 3890.0, 4458.464984201916, 4460.464744230713, 4460.955390446054, 4491.3487544306545, 4505.43682039745, 5073.822416215415, 5234.712090834964, 5242.213667949762, 5253.527182553588, 5255.605829562798, 4324.718893271927, 4378.978105109454, 4385.057212699221, 4388.27593447084, 4431.7562534060935, 4606.493285738566, 4615.30770384445, 4616.3306320584, 4621.768911554409, 4659.091477161988, 4866.416030076342, 4874.220124779948, 4886.560209581155, 4939.703617782944, 4976.32819569368, 5018.799248030038, 5071.2139618359215, 5084.771185296597, 5116.334876466036, 5176.197689358156, 4832.1543729846435, 4848.854534363974, 4849.151398505318, 4849.4908034655855, 4879.609631229422, 5071.898562028812, 5100.6429549931145, 5107.591392688501, 5109.9744501277255, 5160.870978225425, 5030.949690503048, 5059.165237735732, 5076.18780995039, 5082.796688132434, 5185.040767458032, 4993.201087825931, 5000.474950130184, 5003.399592048978, 5006.224035274538, 5058.696478211319, 4984.75076246179, 5018.598512119095, 5020.748962551785, 5025.748712564284, 5029.597632189343, 4831.9275210872565, 4863.7324947128245, 4950.356453661001, 4960.379952505937, 5048.545630893237, 5084.6440749147205, 5097.566706829813, 5104.259882316969, 5105.668131571436, 5153.665011774223, 4972.975135124301, 4986.102501549756, 4987.451380348231, 4987.750612469289, 4988.80044798204], "value": 4742.283266919578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2654869024195, 554.1300158750763, 557.8549577109951, 564.8672561947941, 568.7383803450414, 27781.444371112564, 37423.251534969284, 38796.80601596995, 38901.8054909725, 41948.37077443841, 39270.21459570807, 39570.60429395713, 39626.0, 39680.20639587207, 39704.80147599265, 7149.249328820451, 7443.851122977537, 7573.886391704129, 7586.544807311579, 7592.050993625797, 9483.478408687519, 9719.368241064343, 9736.123748862601, 10066.0, 10074.34516756412, 9763.951180244088, 9858.556364963593, 9869.457179855106, 9873.40759554429, 9879.962603926557, 9684.661036863712, 9723.65967191145, 9762.609495620167, 9762.90237097627, 9764.560594773253, 9562.28282878787, 9626.470544120071, 9627.56675949584, 9636.518174091267, 9640.75898102546, 36826.63173368259, 37178.25643487115, 37203.62796372056, 37238.813805931066, 37253.627463725286, 3045.851528384284, 3167.255694911694, 3249.0415327478213, 3316.4527852904484, 3653.799041052741, 28552.143435696962, 28852.855735721398, 29090.70909290901, 29184.27039324034, 29193.854030729923, 3247.772655914087, 3328.883489077895, 3369.5393641480982, 3385.1029477188563, 3405.557277553902, 246230.0, 246937.0, 247198.0, 247882.0, 247914.0, 47253.29120063202, 52168.0, 52904.47095529072, 53299.86800528013, 53730.462695372546, 55664.0, 56482.7175864118, 56568.71715641396, 56746.0, 56800.71599642058, 13275.535356262484, 13414.932925335506, 13421.456532498692, 13426.932865335611, 13429.127106738031, 8877.778055548662, 9787.265955053399, 9816.165625921734, 9838.60645574169, 9941.801163976825, 17383.565410864576, 17558.824411755973, 17617.0, 17675.73486397705, 17679.911600442174, 6732.730690772314, 6788.389044985975, 6938.410235130071, 6963.442924566022, 7003.618769618354, 797.4218691448654, 872.437277955715, 910.0, 935.3499317973943, 983.6213057972732, 27315.317117071834, 27596.448071038467, 28017.57973630397, 28082.455464949624, 28597.85701071523, 910.8815853939078, 940.8635747816666, 949.6771097826634, 980.3921568627496, 1030.850526673628, 14356.928215358856, 14921.104733716013, 15094.849051509344, 15108.622284442978, 15351.61620959485, 361619.0, 364436.0, 365505.0, 366167.0, 366215.0, 48108.0, 48739.0, 48748.7562562192, 48763.0, 48826.75586622044, 974.858645496399, 1088.7659153282082, 1091.028984204075, 1183.1836033137108, 1194.940252987347, 24904.75095249024, 30705.0, 30711.539326909668, 31106.533401998535, 31700.841495792374, 45643.77178114088, 46152.53847461483, 46252.53747462482, 46254.7687261575, 46288.768556157, 265430.0, 265955.0, 266907.0, 267088.0, 267963.0, 20717.378478645664, 21002.264920727703, 25173.87413062923, 25262.494750104528, 26522.469550608494, 40932.0, 40980.3852942212, 41136.79431602823, 41411.79294103631, 42296.0, 34795.30409391849, 35153.47269791007, 36352.63647363493, 36499.45250821186, 37232.0, 33328.50007249845, 35401.291974160886, 35708.821455892554, 35738.28523429569, 36308.63691363052, 34948.30103397867, 35131.824340878135, 35704.0, 36122.819385902905, 36243.0, 30112.397752045275, 32692.0, 32906.0, 33084.0, 33308.500372493945, 24530.14144504934, 24926.37684057913, 25158.74841251564, 25405.61891571591, 25533.3616659585], "value": 17610.249510183297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.61245080214974, 372.46737165852835, 373.2721193672339, 380.0821017243354, 388.2991200882408, 15621.218939053044, 16548.0, 16857.072860992655, 16867.07231102289, 16932.915335423306, 14891.925540372311, 15340.232988350594, 15560.45538406156, 15625.531234062968, 15669.843301566982, 4768.761561921908, 4982.701037937717, 4987.451380348159, 4988.55103040728, 4991.475895031024, 3690.280395322913, 3809.447630093635, 4928.383952005999, 5614.9719251403685, 5842.47417732404, 5935.10973353996, 5941.168236446901, 5941.673207973559, 5941.910871336933, 5945.37573554777, 5630.831075067755, 5883.735231914574, 5912.763489460416, 5918.526517878559, 5920.585559010871, 5017.84946451607, 5185.818496352647, 5186.170212765977, 5188.92216616751, 5192.480751924777, 19734.0, 19978.500537486678, 20010.69983950242, 20011.099500522512, 20047.599048019103, 1829.938024641048, 2002.0690378973702, 2009.7286866273012, 2058.269314393384, 2080.989595052015, 12642.367881605884, 12783.936080319632, 12789.360531973458, 13007.0, 13469.595912122651, 1736.3835838277355, 1751.8773685841995, 1761.4851227944087, 1780.0387790593063, 1785.8214178582039, 65495.0, 66778.66610666964, 67120.6643966782, 67425.3257467424, 69430.65284673595, 9025.729228123168, 9150.771230719285, 9255.167034966886, 9453.90546094544, 9554.283428742732, 12580.559680411141, 12590.748185036247, 12604.621861344174, 12691.111622186358, 12713.491460341484, 6262.718177682015, 6340.714667839866, 6560.8359791005605, 6571.835704107436, 6574.211094668574, 5927.881442371128, 5928.851778705481, 6098.878022439615, 6121.663308518075, 6130.7241174146375, 5691.03252447085, 5845.9707701462075, 5858.297004359504, 5904.498117659961, 5979.19280897082, 1562.1798555758319, 1653.3634550698068, 1672.5985763416936, 1720.3118752499101, 1735.4099606133975, 853.4409961475244, 859.6260626627312, 867.1501928110487, 868.1318681318681, 902.7743064233941, 16266.268017939221, 16283.430079947146, 16547.83452165463, 16883.0, 17591.472255832345, 852.2925971443686, 854.9059603443616, 891.3092353426017, 911.7994041310901, 934.2245935873209, 9269.933957594829, 9950.353227040365, 9961.950190249003, 9971.202303815677, 10107.3430227035, 353825.0, 359401.0, 360066.0, 363323.0, 363643.0, 39308.6069139305, 39712.80143599321, 47845.0, 63689.0, 66568.33431665719, 881.4887365328223, 891.1623074310128, 906.8277027364779, 909.0818273543637, 935.6491315756591, 15314.770278445609, 15375.231238438257, 16043.197840108181, 16146.657510524456, 16246.512604621881, 38418.231635366574, 38780.0, 38874.4168837462, 38961.610383896936, 39087.41368879526, 50179.0, 50265.0, 50729.746351268004, 51596.74201628968, 53288.73355633197, 6242.375762423721, 7511.849763004819, 7512.107838482115, 7736.226377362219, 7779.844403112019, 8268.793280168044, 10997.395143267197, 11249.818769029134, 11486.253393529729, 11877.14595730158, 9787.853182202414, 10733.0, 10795.0, 10800.135989120694, 10800.24398292112, 10084.798304033731, 10232.59069637206, 10373.118284945864, 10635.042846143884, 10939.726506837393, 10307.278490505592, 10620.150387969099, 10646.20153488476, 10660.360378377321, 10984.890151098387, 7546.471746977659, 7719.263165787877, 7914.089879663912, 7918.9208107920485, 7991.200879911962, 9670.468124252951, 9981.401115933068, 10039.381884333288, 10522.31604945676, 10665.626703065356], "value": 8121.371107444276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.4812197304036, 1398.0982266438148, 1447.8262608486978, 1612.065002298667, 1672.6320209553894, 7378.667959941802, 7956.085050219226, 7975.92024079759, 7986.4010199235, 8000.439969202158, 6709.362610552002, 6905.447564194865, 6912.861742765142, 7057.64711764411, 7838.8040298992555, 1898.3545594497903, 2142.635751922177, 2216.6896634471186, 2225.2322948582714, 2238.0935721033006, 2156.3423155937435, 2202.2072054060604, 2207.7350717913873, 2214.5460180662926, 2227.20934068405, 2197.8681279123302, 2206.6579680149603, 2207.415035015722, 2207.4481379655085, 2207.8896055197256, 2126.2133010786033, 2145.3349461666776, 2158.2230397057047, 2160.7083043789044, 2163.350994701583, 2086.1863873089505, 2109.166879082754, 2111.0, 2119.703241546185, 2121.363590922717, 7712.267334603203, 7900.683972641087, 7922.4850384724805, 7932.881006784845, 7939.0870049944415, 4349.456317960255, 4486.416765820422, 4487.640988720895, 4488.371627972087, 4489.528599497071, 2860.6424196975377, 2957.406750797791, 3019.4866872631706, 3032.9545056824163, 3051.923701907448, 935.1396715022196, 952.1002652493396, 977.0669011094387, 991.9107280344731, 999.6101520407047, 10280.74298142545, 10285.228607854366, 10323.122534584569, 10324.225683073724, 10371.79256414875, 3952.4664170336637, 4058.411530328145, 4258.42511260982, 4271.594198551133, 4293.0769884474985, 8853.468791872509, 8916.242119419921, 8927.598258078273, 8931.240844528158, 8938.37431379797, 4482.394876691605, 4483.865484035484, 4484.0583477469445, 4487.349334346567, 4497.235469970113, 3550.3609350316674, 4070.8575199868455, 4078.4290199372113, 4082.101937573729, 4084.8366065357645, 3324.16895776056, 3518.472229165646, 3539.628339024417, 3656.433252845813, 3683.189698266377, 1173.2901594535354, 1192.9880701192876, 1203.0676225924803, 1211.9757604847853, 1234.672811704899, 744.9404047676173, 845.0788640381891, 846.1115828380299, 847.2798121596594, 862.2326129744532, 5134.871628209325, 5254.579633629301, 5255.789768409298, 5266.526012658879, 5273.630845840831, 831.4678605692362, 866.5840396609536, 907.0339988238555, 915.995420022909, 959.1463597398321, 3350.480675495302, 3479.3215323012278, 3483.54713887193, 3490.2321489272317, 3602.351576716164, 9528.380655257386, 9714.417134971784, 9775.755606109904, 9794.510274486247, 9803.0, 9731.172850307661, 9752.21982241419, 9753.853692194623, 9757.073078057572, 9766.56050477716, 6679.666016699146, 6947.305269473012, 6956.826079347956, 7145.714171433188, 7209.459290553124, 5093.108705976513, 5099.77051032697, 5129.8717532062, 5182.32629758129, 5354.437784032621, 8678.956605216934, 8843.159899809507, 8864.113588641085, 8922.464652120894, 9004.099590041205, 8989.146031127033, 9004.639814407612, 9025.864612030693, 9142.725718228463, 9170.908290917005, 6589.4069533742195, 6827.21487028998, 6957.686904089227, 6957.8956315654295, 6984.685689143899, 7413.629318534159, 7600.087989441303, 7688.692452301845, 7696.961515192388, 7702.537847729154, 6800.693968771318, 6851.315586169717, 6856.348646878539, 7027.543209691354, 7083.433325333858, 6562.179727534059, 6642.568233064835, 6704.128463299739, 6876.037354770437, 6917.308269173042, 6444.194475690539, 6560.8359791005605, 6564.737410503526, 6567.2447668518735, 6569.277379488348, 4331.285337919208, 4346.934795978126, 4432.556744325541, 4465.709728867613, 4488.192125417456, 4465.910681786281, 4476.149531589118, 4620.306953956933, 4694.882627934329, 4859.2954021665955], "value": 4124.458546513206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.9121554749123, 306.0619202145424, 310.3188501239779, 311.62293624714096, 314.2097624474446, 4889.9266511002315, 4917.385326834145, 4921.360223170992, 4934.0, 4956.925646115306, 4774.880627984302, 4858.9514104858945, 4863.489333619963, 4866.513348665132, 4870.732109733964, 3617.891463256093, 3756.9060773480746, 3765.9246815063684, 3786.2616789726017, 3814.7138964577766, 3824.8470061197518, 3830.8276127574327, 3837.2133712588993, 3838.2323535292912, 3839.9072505484437, 3801.3157631626295, 3804.0, 3808.257389808988, 3825.885223443287, 3828.923421531568, 3591.551056117972, 3654.2326111516613, 3795.35478968576, 3804.1060350817534, 3828.693704503633, 3352.6479719629333, 3354.37943980362, 3355.8825441109443, 3365.3605814895336, 3366.1921138926728, 4650.697704649187, 4663.114008338405, 4672.929906051378, 4676.152919596774, 4687.859364219079, 4164.729292595972, 4338.045629961435, 4338.739675619441, 4346.826126954918, 4366.214081465335, 4979.7261150636705, 4998.57512111471, 5003.349564556621, 5004.199328107522, 5033.672811267293, 3676.3382591133586, 3678.668919797231, 3682.342945674457, 3691.427828686558, 3719.702423806089, 5147.176451767737, 5357.0, 5374.167004114369, 5385.2999110115825, 5387.326584176978, 3724.925501489955, 3768.6419790119894, 3773.8867833965023, 3773.9433908491396, 3776.5090538229856, 3806.3148633246283, 3808.27642747877, 3815.523059617548, 3815.73289869712, 3822.7515211511163, 4329.675274354436, 4334.436523251957, 4349.978250108792, 4352.216601011848, 4357.934630980538, 4794.184988551885, 5073.518015788494, 5089.949100509021, 5103.413107492612, 5106.259592359162, 1285.8842704156484, 1286.5239861251398, 1292.8642492538147, 1297.3902265934996, 1298.6104168749525, 792.4769652029748, 822.6257053040972, 828.9212524810133, 843.8227972125923, 844.9915500845036, 4333.913321733611, 4388.890277743082, 4477.529859364785, 4496.348029535699, 4497.460304763449, 5243.580513558906, 5251.868703282448, 5253.973730131325, 5254.108520932461, 5262.842114736564, 4459.710118842265, 4475.082608065339, 4478.462584489882, 4496.808345788369, 4509.241395855619, 2629.8553579552927, 2781.304673831542, 2785.7046473389564, 2787.9442411152068, 2801.3976994946183, 4947.455779864212, 4950.9009819803405, 4953.2570114483115, 4981.427135879348, 4988.775505102279, 5235.947640523622, 5389.164679474688, 5389.541888939484, 5392.811251606175, 5417.972910135424, 4982.999999999927, 4989.276554899592, 5005.224190250517, 5010.67430617016, 5016.247562865527, 5267.657602255841, 5275.815346462856, 5280.947190528045, 5286.709230992333, 5295.470452954673, 5014.598832093351, 5150.742462876916, 5169.121249387688, 5186.447283610588, 5200.947990520046, 4931.926021109614, 4953.504649535162, 4958.6281028923695, 4967.7516124192925, 4973.875653108701, 3358.3954888120375, 3374.0477082552766, 3385.898423047214, 3410.2326976431095, 3410.9829450852585, 4666.34671146033, 4685.718856868599, 4707.29390591414, 4707.529247075265, 4944.629152813625, 5073.974630126973, 5090.796368145381, 5100.285959965682, 5103.622022054099, 5126.6923984561045, 5089.440161582149, 5102.770375333044, 5106.795728170831, 5161.838586318048, 5177.275181474522, 4843.588294994824, 5045.722485263345, 5051.368578927634, 5058.1654027085115, 5076.213186956028, 4902.0, 4965.1807451770055, 5093.1341671915125, 5126.53861152498, 5144.871378215425, 4975.900481990412, 5004.949950500594, 5007.5993920487, 5015.0, 5039.571636410946], "value": 3823.5476285020404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.1678026274395, 629.3643420145652, 658.2298710508704, 680.0003994128629, 736.8231624410141, 12445.751084978296, 13119.212847229173, 13252.337383130853, 13267.336633168352, 13276.269805160724, 13395.464181432731, 13478.5282515112, 13498.865011349908, 13528.120672156303, 13531.25578093207, 619.9628022318675, 734.8052766016983, 746.3879618712672, 762.3634265388407, 766.1993217088157, 764.1556080531017, 770.3721467004401, 770.9421793365492, 774.0363247756551, 775.0389516998908, 817.0889458254034, 817.1909809288791, 818.0960039156736, 818.5007145641155, 820.5199958024533, 654.3816093791321, 787.1262898183012, 806.5443024691031, 813.9674413023472, 814.7474282972297, 585.3005658238407, 590.5895402695129, 592.6858764854634, 592.8814237152544, 593.8129489210885, 11929.0, 11957.282563046245, 11960.64118076459, 11962.282263064244, 11976.401179940967, 12427.689307767288, 12728.936355318165, 12942.891425284844, 13068.803967940488, 13407.262600556965, 11731.53073877044, 11844.40777961107, 11848.111391645574, 11926.224795388272, 12076.0, 4048.1296521247777, 4076.0625056236936, 4129.772862492562, 4174.269502836992, 4177.248095342837, 62785.0, 62788.0, 62931.0, 62969.68515157395, 63053.684731576504, 9993.050660187271, 10033.397996120257, 10228.386296822215, 10896.891031089588, 10911.945440272748, 19734.70397944032, 19745.802541974397, 19753.703694444594, 19761.802381976282, 19767.406977790688, 6940.9652951734915, 6989.790306290819, 7061.89407158893, 7069.575825450489, 7101.822454438577, 3623.239119784822, 3639.29033838399, 3697.131174174067, 3720.069982504374, 3774.094217387807, 2850.5866649336144, 2954.9409011819644, 2963.9259018524276, 2963.925901852471, 2965.154930844699, 489.21236808737905, 493.2084005171719, 540.2650861109374, 555.2476394485494, 562.8958642651122, 571.6198727845936, 583.2388732703862, 595.119223549141, 599.2539288585651, 605.59727781026, 7563.886541701879, 7578.962105189549, 7959.8408031839035, 8243.83512329762, 8320.542370169578, 509.0480800902336, 529.9629025968145, 566.5552541255095, 590.8404730722767, 609.1897775957965, 3602.1174812171184, 3815.7999363867616, 3931.9803400983383, 3947.9013024674036, 3976.204759048202, 99378.0, 107331.0, 108751.77475153485, 111228.0, 111335.88664113256, 68067.31932680709, 68329.0, 70859.64570177117, 84937.57531212304, 85768.57115714382, 70702.64648676723, 70705.0, 71021.0, 72607.0, 73898.26101738914, 7404.851902962018, 7572.583507907118, 7709.612269791492, 7751.302382785577, 7793.37652987771, 43068.35397468978, 43358.56641433672, 43792.0, 44372.0, 44876.77561612171, 35133.472997904544, 37504.0, 39196.216075678894, 58002.709986449794, 64104.35895641171, 10096.646617368357, 10234.283600148216, 10249.0, 10374.844377334497, 10707.357558546511, 11951.37913979255, 12078.758424831278, 12611.30637814929, 12749.426275817796, 13090.280034598189, 10307.587696492057, 10914.126869850234, 11247.0, 11501.367424791717, 11575.42122893835, 10687.5190616424, 11203.271787333797, 11483.655490335303, 11786.882131178578, 11815.0, 10822.188335874684, 11530.365829879438, 11650.30098194111, 11656.766864662828, 11671.76656466883, 7985.960070199611, 8078.596070196584, 8271.090180080308, 8365.414420990472, 8540.27407670355, 8487.908715130863, 9097.363184577016, 9111.407758495676, 9145.771355715895, 9190.586423611087], "value": 6433.058184878016, "unit": "score"}], "name": "dromaeo_css", "value": 6401.4799067338845, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 114.0, 116.0, 110.0, 115.0, 116.0, 115.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 121.0, 188.0, 123.0, 123.0, 149.0, 121.0, 196.0, 127.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 161.0, 161.0, 162.0, 163.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 113.0, 77.0, 76.0, 75.0, 76.0, 128.0, 75.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 143.0, 88.0, 88.0, 86.0, 126.0, 86.0, 86.0, 130.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 119.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 64.0, 67.0, 65.0, 65.0, 68.0, 65.0, 64.0, 67.0, 64.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 68.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 83.0, 83.0, 83.0, 83.0, 81.0, 82.0, 81.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 132.0, 131.0, 131.0, 134.0, 137.0, 147.0, 157.0, 134.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 172.0, 175.0, 175.0, 169.0, 170.0, 173.0, 170.0, 171.0, 179.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 67.0, 68.0, 70.0, 67.0, 67.0, 67.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1553.8999999999999, "alertThreshold": 2.0}]} 05:58:15 INFO - Return code: 0 05:58:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:58:16 INFO - # TBPL SUCCESS # 05:58:16 INFO - Running post-action listener: _resource_record_post_action 05:58:16 INFO - [mozharness: 2016-08-16 12:58:16.057725Z] Finished run-tests step (success) 05:58:16 INFO - Running post-run listener: _resource_record_post_run 05:58:16 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417554432; Read time: 20; Write time: 554144 05:58:16 INFO - TinderboxPrint: CPU usage
13.0% 05:58:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:58:16 INFO - TinderboxPrint: I/O write bytes / time
417,554,432 / 554,144 05:58:16 INFO - TinderboxPrint: CPU idle
8,353.1 (87.0%) 05:58:16 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 05:58:16 INFO - TinderboxPrint: Swap in / out
0 / 0 05:58:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125239296; Read time: 0; Write time: 230196 05:58:16 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292315136; Read time: 0; Write time: 323948 05:58:16 INFO - Running post-run listener: _upload_blobber_files 05:58:16 INFO - Blob upload gear active. 05:58:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:16 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 05:58:16 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'] 05:58:16 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 05:58:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:18 INFO - (blobuploader) - INFO - Done attempting. 05:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:23 INFO - (blobuploader) - INFO - Done attempting. 05:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:58:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:24 INFO - (blobuploader) - INFO - Done attempting. 05:58:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:24 INFO - Return code: 0 05:58:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5299ac630d81c95e5d9bc31638515c47083b240edcfab830eb29a597c3a5703640d26f442a5e1d6ab75d4e08685116e90e05aeabd601ca136b5090674904290b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6d0db44a6f88fe7198f417efaac62b62a6871363ee1d315efb7d28637dd9b971a66fdbbb965196794c19a5c0b8aab0e4c98ae3674d6fef1ce397e8f12af41c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc6c7249b071b9b58e8677a7b40afe8d02adc1168ca10c0f4f9024ddeece4d22bc2053dd05066eebfd1464d7a5b84d202609549c3f5129ddb78c219761ca8a6"} 05:58:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:24 INFO - Contents: 05:58:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5299ac630d81c95e5d9bc31638515c47083b240edcfab830eb29a597c3a5703640d26f442a5e1d6ab75d4e08685116e90e05aeabd601ca136b5090674904290b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6d0db44a6f88fe7198f417efaac62b62a6871363ee1d315efb7d28637dd9b971a66fdbbb965196794c19a5c0b8aab0e4c98ae3674d6fef1ce397e8f12af41c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc6c7249b071b9b58e8677a7b40afe8d02adc1168ca10c0f4f9024ddeece4d22bc2053dd05066eebfd1464d7a5b84d202609549c3f5129ddb78c219761ca8a6"} 05:58:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:24 INFO - Copying logs to upload dir... 05:58:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.533922 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-16 05:58:24.087188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:58:24.090593) ========= 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=eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667 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/5299ac630d81c95e5d9bc31638515c47083b240edcfab830eb29a597c3a5703640d26f442a5e1d6ab75d4e08685116e90e05aeabd601ca136b5090674904290b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6d0db44a6f88fe7198f417efaac62b62a6871363ee1d315efb7d28637dd9b971a66fdbbb965196794c19a5c0b8aab0e4c98ae3674d6fef1ce397e8f12af41c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc6c7249b071b9b58e8677a7b40afe8d02adc1168ca10c0f4f9024ddeece4d22bc2053dd05066eebfd1464d7a5b84d202609549c3f5129ddb78c219761ca8a6"} build_url:https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/bCPsAMZlSiCHIEFb_TdePw/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/5299ac630d81c95e5d9bc31638515c47083b240edcfab830eb29a597c3a5703640d26f442a5e1d6ab75d4e08685116e90e05aeabd601ca136b5090674904290b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6d0db44a6f88fe7198f417efaac62b62a6871363ee1d315efb7d28637dd9b971a66fdbbb965196794c19a5c0b8aab0e4c98ae3674d6fef1ce397e8f12af41c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc6c7249b071b9b58e8677a7b40afe8d02adc1168ca10c0f4f9024ddeece4d22bc2053dd05066eebfd1464d7a5b84d202609549c3f5129ddb78c219761ca8a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:58:24.115857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:58:24.116194) ========= 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=eca2ab57546de7b41f256b19000001ef-1471351054.860736-1093510667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:58:24.199065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:58:24.199388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:58:24.199675) ========= ========= Total master_lag: 0.17 =========