builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1472537784.34 results: success (0) buildid: 20160829203012 builduid: 8cdc7fba8ccf4ca1aa7b510744f4e89e revision: fecb1018cdcbf931db0892b6fba2e8348286f1d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.343818) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.344382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.347444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.364904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.365305) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 23:16:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-08-29 23:16:25 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.592088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.592863) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.646606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:24.647284) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fecb1018cdcbf931db0892b6fba2e8348286f1d8 --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 fecb1018cdcbf931db0892b6fba2e8348286f1d8 --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=bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 23:16:25,204 truncating revision to first 12 chars 2016-08-29 23:16:25,204 Setting DEBUG logging. 2016-08-29 23:16:25,204 attempt 1/10 2016-08-29 23:16:25,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fecb1018cdcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 23:16:25,493 unpacking tar archive at: fx-team-fecb1018cdcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:25.220538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:25.221131) ========= script_repo_revision: fecb1018cdcbf931db0892b6fba2e8348286f1d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:25.221826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:25.222325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 23:16:25.234891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-29 23:16:25.235468) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:16:25 INFO - MultiFileLogger online at 20160829 23:16:25 in /builds/slave/test 23:16:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:16:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:16:25 INFO - {'append_to_log': False, 23:16:25 INFO - 'base_work_dir': '/builds/slave/test', 23:16:25 INFO - 'blob_upload_branch': 'Fx-Team', 23:16:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:16:25 INFO - 'branch': 'Fx-Team', 23:16:25 INFO - 'buildbot_json_path': 'buildprops.json', 23:16:25 INFO - 'config_files': ('talos/linux_config.py',), 23:16:25 INFO - 'default_actions': ('clobber', 23:16:25 INFO - 'read-buildbot-config', 23:16:25 INFO - 'download-and-extract', 23:16:25 INFO - 'populate-webroot', 23:16:25 INFO - 'create-virtualenv', 23:16:25 INFO - 'install', 23:16:25 INFO - 'run-tests'), 23:16:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:16:25 INFO - 'download_minidump_stackwalk': True, 23:16:25 INFO - 'download_symbols': 'ondemand', 23:16:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:16:25 INFO - 'tooltool.py': '/tools/tooltool.py', 23:16:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:16:25 INFO - '/tools/misc-python/virtualenv.py')}, 23:16:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:16:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:16:25 INFO - 'installer_path': 'installer.exe', 23:16:25 INFO - 'log_level': 'info', 23:16:25 INFO - 'log_name': 'talos', 23:16:25 INFO - 'log_to_console': True, 23:16:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:16:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:16:25 INFO - 'opt_config_files': (), 23:16:25 INFO - 'pip_index': False, 23:16:25 INFO - 'sps_profile': False, 23:16:25 INFO - 'sps_profile_interval': 0, 23:16:25 INFO - 'suite': 'dromaeojs', 23:16:25 INFO - 'system_bits': '32', 23:16:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:16:25 INFO - 'title': 'talos-linux64-ix-055', 23:16:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:16:25 INFO - 'use_talos_json': True, 23:16:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:16:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:16:25 INFO - 'work_dir': 'build'} 23:16:25 INFO - [mozharness: 2016-08-30 06:16:25.889310Z] Running clobber step. 23:16:25 INFO - Running pre-action listener: _resource_record_pre_action 23:16:25 INFO - Running main action method: clobber 23:16:25 INFO - rmtree: /builds/slave/test/build 23:16:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:16:26 INFO - Running post-action listener: _resource_record_post_action 23:16:26 INFO - [mozharness: 2016-08-30 06:16:26.850023Z] Finished clobber step (success) 23:16:26 INFO - [mozharness: 2016-08-30 06:16:26.850124Z] Running read-buildbot-config step. 23:16:26 INFO - Running pre-action listener: _resource_record_pre_action 23:16:26 INFO - Running main action method: read_buildbot_config 23:16:26 INFO - Using buildbot properties: 23:16:26 INFO - { 23:16:26 INFO - "project": "", 23:16:26 INFO - "product": "firefox", 23:16:26 INFO - "script_repo_revision": "production", 23:16:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:16:26 INFO - "repository": "", 23:16:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:16:26 INFO - "buildid": "20160829203012", 23:16:26 INFO - "pgo_build": "True", 23:16:26 INFO - "basedir": "/builds/slave/test", 23:16:26 INFO - "buildnumber": 405, 23:16:26 INFO - "slavename": "talos-linux64-ix-055", 23:16:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:16:26 INFO - "platform": "ubuntu64_hw", 23:16:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:16:26 INFO - "branch": "fx-team", 23:16:26 INFO - "repo_path": "integration/fx-team", 23:16:26 INFO - "revision": "fecb1018cdcbf931db0892b6fba2e8348286f1d8", 23:16:26 INFO - "stage_platform": "linux64-pgo", 23:16:26 INFO - "builduid": "8cdc7fba8ccf4ca1aa7b510744f4e89e", 23:16:26 INFO - "slavebuilddir": "test" 23:16:26 INFO - } 23:16:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:16:26 INFO - Running post-action listener: _resource_record_post_action 23:16:26 INFO - [mozharness: 2016-08-30 06:16:26.852552Z] Finished read-buildbot-config step (success) 23:16:26 INFO - [mozharness: 2016-08-30 06:16:26.852642Z] Running download-and-extract step. 23:16:26 INFO - Running pre-action listener: _resource_record_pre_action 23:16:26 INFO - Running main action method: download_and_extract 23:16:26 INFO - mkdir: /builds/slave/test/build/tests 23:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:26 INFO - trying https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:27 INFO - Downloaded 1361 bytes. 23:16:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:27 INFO - Using the following test package requirements: 23:16:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'jsshell-linux-x86_64.zip'], 23:16:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16:27 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')]} 23:16:27 INFO - trying https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:28 INFO - Downloaded 21886942 bytes. 23:16:28 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 23:16:32 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 23:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:32 INFO - trying https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:33 INFO - Downloaded 21886942 bytes. 23:16:33 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 23:16: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')]} 23:16:37 INFO - trying https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:38 INFO - Downloaded 14413998 bytes. 23:16:38 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 23:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:38 INFO - trying https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/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 23:16:40 INFO - Downloaded 59738775 bytes. 23:16:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:40 INFO - mkdir: /builds/slave/test/properties 23:16:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:16:40 INFO - Writing to file /builds/slave/test/properties/build_url 23:16:40 INFO - Contents: 23:16:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:41 INFO - Running post-action listener: _resource_record_post_action 23:16:41 INFO - Running post-action listener: set_extra_try_arguments 23:16:41 INFO - [mozharness: 2016-08-30 06:16:41.402540Z] Finished download-and-extract step (success) 23:16:41 INFO - [mozharness: 2016-08-30 06:16:41.402766Z] Running populate-webroot step. 23:16:41 INFO - Running pre-action listener: _resource_record_pre_action 23:16:41 INFO - Running main action method: populate_webroot 23:16:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:16:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:16:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:16:41 INFO - '--tppagecycles', 23:16:41 INFO - '7'], 23:16:41 INFO - 'tests': ['tsvgm']}}, 23:16:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:16:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:16:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:16:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:16:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['damp', 'tps']}, 23:16:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'tests': ['damp', 'tps']}, 23:16:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['dromaeo_dom']}, 23:16:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:16:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['basic_compositor_video']}, 23:16:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:16:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other-e10s': {'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tsvgx', 23:16:41 INFO - 'tsvgr_opacity', 23:16:41 INFO - 'tart', 23:16:41 INFO - 'tscrollx', 23:16:41 INFO - 'cart']}, 23:16:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:16:41 INFO - 'tsvgr_opacity', 23:16:41 INFO - 'tart', 23:16:41 INFO - 'tscrollx', 23:16:41 INFO - 'cart']}, 23:16:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tp5o']}, 23:16:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'tests': ['tp5o']}, 23:16:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s', 23:16:41 INFO - '--xperf_path', 23:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:41 INFO - 'tests': ['tp5n']}, 23:16:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--xperf_path', 23:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:41 INFO - 'tests': ['tp5n']}}, 23:16:41 INFO - 'talos.zip': {'path': '', 23:16:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:16:41 INFO - Running post-action listener: _resource_record_post_action 23:16:41 INFO - [mozharness: 2016-08-30 06:16:41.423976Z] Finished populate-webroot step (success) 23:16:41 INFO - [mozharness: 2016-08-30 06:16:41.424065Z] Running create-virtualenv step. 23:16:41 INFO - Running pre-action listener: _resource_record_pre_action 23:16:41 INFO - Running main action method: create_virtualenv 23:16:41 INFO - Creating virtualenv /builds/slave/test/build/venv 23:16:41 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 23:16:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:16:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:16:41 INFO - Using real prefix '/usr' 23:16:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:16:42 INFO - Installing distribute.............................................................................................................................................................................................done. 23:16:44 INFO - Installing pip.................done. 23:16:44 INFO - Return code: 0 23:16:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:44 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 23:16:44 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 23:16:44 INFO - Using env: {'DISPLAY': ':0', 23:16:44 INFO - 'HOME': '/home/cltbld', 23:16:44 INFO - 'LANG': 'en_US.UTF-8', 23:16:44 INFO - 'LANGUAGE': 'en_US:en', 23:16:44 INFO - 'LOGNAME': 'cltbld', 23:16:44 INFO - 'MAIL': '/var/mail/cltbld', 23:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:44 INFO - 'MOZ_NO_REMOTE': '1', 23:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:44 INFO - 'NO_EM_RESTART': '1', 23:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:44 INFO - 'PWD': '/builds/slave/test', 23:16:44 INFO - 'SHELL': '/bin/bash', 23:16:44 INFO - 'SHLVL': '1', 23:16:44 INFO - 'TERM': 'linux', 23:16:44 INFO - 'TMOUT': '86400', 23:16:44 INFO - 'USER': 'cltbld', 23:16:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:44 INFO - '_': '/tools/buildbot/bin/python'} 23:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:44 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 23:16:44 INFO - Cleaning up... 23:16:44 INFO - Return code: 0 23:16:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:44 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 23:16:44 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 23:16:44 INFO - Using env: {'DISPLAY': ':0', 23:16:44 INFO - 'HOME': '/home/cltbld', 23:16:44 INFO - 'LANG': 'en_US.UTF-8', 23:16:44 INFO - 'LANGUAGE': 'en_US:en', 23:16:44 INFO - 'LOGNAME': 'cltbld', 23:16:44 INFO - 'MAIL': '/var/mail/cltbld', 23:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:44 INFO - 'MOZ_NO_REMOTE': '1', 23:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:44 INFO - 'NO_EM_RESTART': '1', 23:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:44 INFO - 'PWD': '/builds/slave/test', 23:16:44 INFO - 'SHELL': '/bin/bash', 23:16:44 INFO - 'SHLVL': '1', 23:16:44 INFO - 'TERM': 'linux', 23:16:44 INFO - 'TMOUT': '86400', 23:16:44 INFO - 'USER': 'cltbld', 23:16:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:44 INFO - '_': '/tools/buildbot/bin/python'} 23:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:44 INFO - Downloading/unpacking psutil>=3.1.1 23:16:44 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 23:16:44 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 23:16:44 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 23:16:44 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 23:16:44 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 23:16:44 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 23:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:46 INFO - Installing collected packages: psutil 23:16:46 INFO - Running setup.py install for psutil 23:16:46 INFO - building 'psutil._psutil_linux' extension 23:16:46 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 23:16:46 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 23:16:46 INFO - building 'psutil._psutil_posix' extension 23:16:46 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 23:16:46 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 23:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:46 INFO - Successfully installed psutil 23:16:46 INFO - Cleaning up... 23:16:46 INFO - Return code: 0 23:16:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:16:47 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')]} 23:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 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')]} 23:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:47 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 23:16:47 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 23:16:47 INFO - Using env: {'DISPLAY': ':0', 23:16:47 INFO - 'HOME': '/home/cltbld', 23:16:47 INFO - 'LANG': 'en_US.UTF-8', 23:16:47 INFO - 'LANGUAGE': 'en_US:en', 23:16:47 INFO - 'LOGNAME': 'cltbld', 23:16:47 INFO - 'MAIL': '/var/mail/cltbld', 23:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:47 INFO - 'MOZ_NO_REMOTE': '1', 23:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:47 INFO - 'NO_EM_RESTART': '1', 23:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:47 INFO - 'PWD': '/builds/slave/test', 23:16:47 INFO - 'SHELL': '/bin/bash', 23:16:47 INFO - 'SHLVL': '1', 23:16:47 INFO - 'TERM': 'linux', 23:16:47 INFO - 'TMOUT': '86400', 23:16:47 INFO - 'USER': 'cltbld', 23:16:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:47 INFO - '_': '/tools/buildbot/bin/python'} 23:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:16:47 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 23:16:47 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 23:16:47 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 23:16:47 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 23:16:47 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 23:16:47 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 23:16:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:16:49 INFO - Installing collected packages: mozsystemmonitor 23:16:49 INFO - Running setup.py install for mozsystemmonitor 23:16:49 INFO - Successfully installed mozsystemmonitor 23:16:49 INFO - Cleaning up... 23:16:49 INFO - Return code: 0 23:16:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:16:49 INFO - Using env: {'DISPLAY': ':0', 23:16:49 INFO - 'HOME': '/home/cltbld', 23:16:49 INFO - 'LANG': 'en_US.UTF-8', 23:16:49 INFO - 'LANGUAGE': 'en_US:en', 23:16:49 INFO - 'LOGNAME': 'cltbld', 23:16:49 INFO - 'MAIL': '/var/mail/cltbld', 23:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:49 INFO - 'MOZ_NO_REMOTE': '1', 23:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:49 INFO - 'NO_EM_RESTART': '1', 23:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:49 INFO - 'PWD': '/builds/slave/test', 23:16:49 INFO - 'SHELL': '/bin/bash', 23:16:49 INFO - 'SHLVL': '1', 23:16:49 INFO - 'TERM': 'linux', 23:16:49 INFO - 'TMOUT': '86400', 23:16:49 INFO - 'USER': 'cltbld', 23:16:49 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:49 INFO - '_': '/tools/buildbot/bin/python'} 23:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:49 INFO - Downloading/unpacking jsonschema==2.5.1 23:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:16:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:51 INFO - Downloading functools32-3.2.3-2.tar.gz 23:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:16:51 INFO - warning: no files found matching '*.txt' 23:16:51 INFO - no previously-included directories found matching 'build' 23:16:51 INFO - no previously-included directories found matching 'dist' 23:16:51 INFO - no previously-included directories found matching '.git*' 23:16:51 INFO - Installing collected packages: jsonschema, functools32 23:16:51 INFO - Running setup.py install for functools32 23:16:51 INFO - warning: no files found matching '*.txt' 23:16:51 INFO - no previously-included directories found matching 'build' 23:16:51 INFO - no previously-included directories found matching 'dist' 23:16:51 INFO - no previously-included directories found matching '.git*' 23:16:51 INFO - Successfully installed jsonschema functools32 23:16:51 INFO - Cleaning up... 23:16:51 INFO - Return code: 0 23:16:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:16:51 INFO - Using env: {'DISPLAY': ':0', 23:16:51 INFO - 'HOME': '/home/cltbld', 23:16:51 INFO - 'LANG': 'en_US.UTF-8', 23:16:51 INFO - 'LANGUAGE': 'en_US:en', 23:16:51 INFO - 'LOGNAME': 'cltbld', 23:16:51 INFO - 'MAIL': '/var/mail/cltbld', 23:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:51 INFO - 'MOZ_NO_REMOTE': '1', 23:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:51 INFO - 'NO_EM_RESTART': '1', 23:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:51 INFO - 'PWD': '/builds/slave/test', 23:16:51 INFO - 'SHELL': '/bin/bash', 23:16:51 INFO - 'SHLVL': '1', 23:16:51 INFO - 'TERM': 'linux', 23:16:51 INFO - 'TMOUT': '86400', 23:16:51 INFO - 'USER': 'cltbld', 23:16:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:51 INFO - '_': '/tools/buildbot/bin/python'} 23:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:16:52 INFO - Cleaning up... 23:16:52 INFO - Return code: 0 23:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:16:52 INFO - Using env: {'DISPLAY': ':0', 23:16:52 INFO - 'HOME': '/home/cltbld', 23:16:52 INFO - 'LANG': 'en_US.UTF-8', 23:16:52 INFO - 'LANGUAGE': 'en_US:en', 23:16:52 INFO - 'LOGNAME': 'cltbld', 23:16:52 INFO - 'MAIL': '/var/mail/cltbld', 23:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:52 INFO - 'MOZ_NO_REMOTE': '1', 23:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:52 INFO - 'NO_EM_RESTART': '1', 23:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:52 INFO - 'PWD': '/builds/slave/test', 23:16:52 INFO - 'SHELL': '/bin/bash', 23:16:52 INFO - 'SHLVL': '1', 23:16:52 INFO - 'TERM': 'linux', 23:16:52 INFO - 'TMOUT': '86400', 23:16:52 INFO - 'USER': 'cltbld', 23:16:52 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:52 INFO - '_': '/tools/buildbot/bin/python'} 23:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:52 INFO - Downloading/unpacking blobuploader==1.2.4 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:16:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:54 INFO - Downloading docopt-0.6.1.tar.gz 23:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:55 INFO - Running setup.py install for blobuploader 23:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:55 INFO - Running setup.py install for requests 23:16:55 INFO - Running setup.py install for docopt 23:16:55 INFO - Successfully installed blobuploader requests docopt 23:16:55 INFO - Cleaning up... 23:16:55 INFO - Return code: 0 23:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:55 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')]} 23:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:55 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')]} 23:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:55 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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:55 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 23:16:55 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 23:16:55 INFO - Using env: {'DISPLAY': ':0', 23:16:55 INFO - 'HOME': '/home/cltbld', 23:16:55 INFO - 'LANG': 'en_US.UTF-8', 23:16:55 INFO - 'LANGUAGE': 'en_US:en', 23:16:55 INFO - 'LOGNAME': 'cltbld', 23:16:55 INFO - 'MAIL': '/var/mail/cltbld', 23:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:55 INFO - 'MOZ_NO_REMOTE': '1', 23:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:55 INFO - 'NO_EM_RESTART': '1', 23:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:55 INFO - 'PWD': '/builds/slave/test', 23:16:55 INFO - 'SHELL': '/bin/bash', 23:16:55 INFO - 'SHLVL': '1', 23:16:55 INFO - 'TERM': 'linux', 23:16:55 INFO - 'TMOUT': '86400', 23:16:55 INFO - 'USER': 'cltbld', 23:16:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:55 INFO - '_': '/tools/buildbot/bin/python'} 23:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:55 INFO - Running setup.py (path:/tmp/pip-bMeGKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:55 INFO - Running setup.py (path:/tmp/pip-531ijt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:55 INFO - Running setup.py (path:/tmp/pip-PaQblu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:56 INFO - Running setup.py (path:/tmp/pip-rN1MSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:56 INFO - Running setup.py (path:/tmp/pip-PcVOzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:56 INFO - Running setup.py (path:/tmp/pip-hssAxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:56 INFO - Running setup.py (path:/tmp/pip-EP3EG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:56 INFO - Running setup.py (path:/tmp/pip-DQhj_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:56 INFO - Running setup.py (path:/tmp/pip-_iAfMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:56 INFO - Running setup.py (path:/tmp/pip-MLOgUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:56 INFO - Running setup.py (path:/tmp/pip-X6GlZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:56 INFO - Running setup.py (path:/tmp/pip-wmETle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:56 INFO - Running setup.py (path:/tmp/pip-3PfELk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:56 INFO - Running setup.py (path:/tmp/pip-bypugo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:56 INFO - Running setup.py (path:/tmp/pip-wE3jwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:56 INFO - Running setup.py (path:/tmp/pip-sojYl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:56 INFO - Running setup.py (path:/tmp/pip-ks9e8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:57 INFO - Running setup.py install for manifestparser 23:16:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozcrash 23:16:57 INFO - Running setup.py install for mozdebug 23:16:57 INFO - Running setup.py install for mozdevice 23:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozfile 23:16:57 INFO - Running setup.py install for mozhttpd 23:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozinfo 23:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozInstall 23:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozleak 23:16:57 INFO - Running setup.py install for mozlog 23:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for moznetwork 23:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozprocess 23:16:58 INFO - Running setup.py install for mozprofile 23:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozrunner 23:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozscreenshot 23:16:58 INFO - Running setup.py install for moztest 23:16:58 INFO - Running setup.py install for mozversion 23:16:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:58 INFO - Cleaning up... 23:16:58 INFO - Return code: 0 23:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:58 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')]} 23:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:58 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')]} 23:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:58 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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:16:58 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 23:16:58 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 23:16:58 INFO - Using env: {'DISPLAY': ':0', 23:16:58 INFO - 'HOME': '/home/cltbld', 23:16:58 INFO - 'LANG': 'en_US.UTF-8', 23:16:58 INFO - 'LANGUAGE': 'en_US:en', 23:16:58 INFO - 'LOGNAME': 'cltbld', 23:16:58 INFO - 'MAIL': '/var/mail/cltbld', 23:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:58 INFO - 'MOZ_NO_REMOTE': '1', 23:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:58 INFO - 'NO_EM_RESTART': '1', 23:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:58 INFO - 'PWD': '/builds/slave/test', 23:16:58 INFO - 'SHELL': '/bin/bash', 23:16:58 INFO - 'SHLVL': '1', 23:16:58 INFO - 'TERM': 'linux', 23:16:58 INFO - 'TMOUT': '86400', 23:16:58 INFO - 'USER': 'cltbld', 23:16:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:58 INFO - '_': '/tools/buildbot/bin/python'} 23:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:59 INFO - Running setup.py (path:/tmp/pip-XhzP6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:59 INFO - Running setup.py (path:/tmp/pip-IQjCF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:59 INFO - Running setup.py (path:/tmp/pip-MozPrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:59 INFO - Running setup.py (path:/tmp/pip-CcUtrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:59 INFO - Running setup.py (path:/tmp/pip-7EgLjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:59 INFO - Running setup.py (path:/tmp/pip-bgmtMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:59 INFO - Running setup.py (path:/tmp/pip-KuRblb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:59 INFO - Running setup.py (path:/tmp/pip-qzRRHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:59 INFO - Running setup.py (path:/tmp/pip-UqoXEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:59 INFO - Running setup.py (path:/tmp/pip-BXyRyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:59 INFO - Running setup.py (path:/tmp/pip-wYdVE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:59 INFO - Running setup.py (path:/tmp/pip-KAG6qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:59 INFO - Running setup.py (path:/tmp/pip-8xvELL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:00 INFO - Running setup.py (path:/tmp/pip-CUNEXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:00 INFO - Running setup.py (path:/tmp/pip-hn9QxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:00 INFO - Running setup.py (path:/tmp/pip-hpJLR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:00 INFO - Running setup.py (path:/tmp/pip-9ZKmYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:02 INFO - Downloading blessings-1.6.tar.gz 23:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:17:02 INFO - Installing collected packages: blessings 23:17:02 INFO - Running setup.py install for blessings 23:17:02 INFO - Successfully installed blessings 23:17:02 INFO - Cleaning up... 23:17:02 INFO - Return code: 0 23:17:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:17:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:02 INFO - Reading from file tmpfile_stdout 23:17:02 INFO - Current package versions: 23:17:02 INFO - argparse == 1.2.1 23:17:02 INFO - blessings == 1.6 23:17:02 INFO - blobuploader == 1.2.4 23:17:02 INFO - docopt == 0.6.1 23:17:02 INFO - functools32 == 3.2.3-2 23:17:02 INFO - jsonschema == 2.5.1 23:17:02 INFO - manifestparser == 1.1 23:17:02 INFO - mozInstall == 1.12 23:17:02 INFO - mozcrash == 0.17 23:17:02 INFO - mozdebug == 0.1 23:17:02 INFO - mozdevice == 0.48 23:17:02 INFO - mozfile == 1.2 23:17:02 INFO - mozhttpd == 0.7 23:17:02 INFO - mozinfo == 0.9 23:17:02 INFO - mozleak == 0.1 23:17:02 INFO - mozlog == 3.3 23:17:02 INFO - moznetwork == 0.27 23:17:02 INFO - mozprocess == 0.23 23:17:02 INFO - mozprofile == 0.28 23:17:02 INFO - mozrunner == 6.12 23:17:02 INFO - mozscreenshot == 0.1 23:17:02 INFO - mozsystemmonitor == 0.3 23:17:02 INFO - moztest == 0.7 23:17:02 INFO - mozversion == 1.4 23:17:02 INFO - psutil == 3.1.1 23:17:02 INFO - requests == 1.2.3 23:17:02 INFO - wsgiref == 0.1.2 23:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 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 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:17:02 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 23:17:02 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 23:17:02 INFO - Using env: {'DISPLAY': ':0', 23:17:02 INFO - 'HOME': '/home/cltbld', 23:17:02 INFO - 'LANG': 'en_US.UTF-8', 23:17:02 INFO - 'LANGUAGE': 'en_US:en', 23:17:02 INFO - 'LOGNAME': 'cltbld', 23:17:02 INFO - 'MAIL': '/var/mail/cltbld', 23:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:02 INFO - 'MOZ_NO_REMOTE': '1', 23:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:02 INFO - 'NO_EM_RESTART': '1', 23:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:02 INFO - 'PWD': '/builds/slave/test', 23:17:02 INFO - 'SHELL': '/bin/bash', 23:17:02 INFO - 'SHLVL': '1', 23:17:02 INFO - 'TERM': 'linux', 23:17:02 INFO - 'TMOUT': '86400', 23:17:02 INFO - 'USER': 'cltbld', 23:17:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:02 INFO - '_': '/tools/buildbot/bin/python'} 23:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 INFO - Cleaning up... 23:17:02 INFO - Return code: 0 23:17:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c0bd9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afe850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', '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 23:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:17:02 INFO - Using env: {'DISPLAY': ':0', 23:17:02 INFO - 'HOME': '/home/cltbld', 23:17:02 INFO - 'LANG': 'en_US.UTF-8', 23:17:02 INFO - 'LANGUAGE': 'en_US:en', 23:17:02 INFO - 'LOGNAME': 'cltbld', 23:17:02 INFO - 'MAIL': '/var/mail/cltbld', 23:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:02 INFO - 'MOZ_NO_REMOTE': '1', 23:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:02 INFO - 'NO_EM_RESTART': '1', 23:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:02 INFO - 'PWD': '/builds/slave/test', 23:17:02 INFO - 'SHELL': '/bin/bash', 23:17:02 INFO - 'SHLVL': '1', 23:17:02 INFO - 'TERM': 'linux', 23:17:02 INFO - 'TMOUT': '86400', 23:17:02 INFO - 'USER': 'cltbld', 23:17:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:02 INFO - '_': '/tools/buildbot/bin/python'} 23:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:17:03 INFO - Cleaning up... 23:17:03 INFO - Return code: 0 23:17:03 INFO - Running post-action listener: _resource_record_post_action 23:17:03 INFO - Running post-action listener: _start_resource_monitoring 23:17:03 INFO - Starting resource monitoring. 23:17:03 INFO - [mozharness: 2016-08-30 06:17:03.187440Z] Finished create-virtualenv step (success) 23:17:03 INFO - [mozharness: 2016-08-30 06:17:03.187932Z] Running install step. 23:17:03 INFO - Running pre-action listener: _resource_record_pre_action 23:17:03 INFO - Running main action method: install 23:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:03 INFO - Reading from file tmpfile_stdout 23:17:03 INFO - Detecting whether we're running mozinstall >=1.0... 23:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:17:03 INFO - Reading from file tmpfile_stdout 23:17:03 INFO - Output received: 23:17:03 INFO - Usage: mozinstall [options] installer 23:17:03 INFO - Options: 23:17:03 INFO - -h, --help show this help message and exit 23:17:03 INFO - -d DEST, --destination=DEST 23:17:03 INFO - Directory to install application into. [default: 23:17:03 INFO - "/builds/slave/test"] 23:17:03 INFO - --app=APP Application being installed. [default: firefox] 23:17:03 INFO - mkdir: /builds/slave/test/build/application 23:17:03 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'] 23:17:03 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 23:17:20 INFO - Reading from file tmpfile_stdout 23:17:20 INFO - Output received: 23:17:20 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:20 INFO - Running post-action listener: _resource_record_post_action 23:17:20 INFO - [mozharness: 2016-08-30 06:17:20.486004Z] Finished install step (success) 23:17:20 INFO - [mozharness: 2016-08-30 06:17:20.486348Z] Running run-tests step. 23:17:20 INFO - Running pre-action listener: _resource_record_pre_action 23:17:20 INFO - Running main action method: run_tests 23:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:20 INFO - Python 2.7.3 23:17:20 INFO - Return code: 0 23:17:20 INFO - grabbing minidump binary from tooltool 23:17:20 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')]} 23:17:20 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 0x1af9370>, '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 0x1afc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afcd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:20 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 23:17:20 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 23:17:20 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 23:17:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:20 INFO - Return code: 0 23:17:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 23:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 23:17:20 INFO - Using env: {'DISPLAY': ':0', 23:17:20 INFO - 'HOME': '/home/cltbld', 23:17:20 INFO - 'LANG': 'en_US.UTF-8', 23:17:20 INFO - 'LANGUAGE': 'en_US:en', 23:17:20 INFO - 'LOGNAME': 'cltbld', 23:17:20 INFO - 'MAIL': '/var/mail/cltbld', 23:17:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:20 INFO - 'MOZ_NO_REMOTE': '1', 23:17:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:20 INFO - 'NO_EM_RESTART': '1', 23:17:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:20 INFO - 'PWD': '/builds/slave/test', 23:17:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:20 INFO - 'SHELL': '/bin/bash', 23:17:20 INFO - 'SHLVL': '1', 23:17:20 INFO - 'TERM': 'linux', 23:17:20 INFO - 'TMOUT': '86400', 23:17:20 INFO - 'USER': 'cltbld', 23:17:20 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696', 23:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:20 INFO - '_': '/tools/buildbot/bin/python'} 23:17:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 23:17:20 INFO - mozversion application_buildid: 20160829203012 23:17:20 INFO - mozversion application_changeset: fecb1018cdcbf931db0892b6fba2e8348286f1d8 23:17:20 INFO - mozversion application_display_name: Nightly 23:17:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:20 INFO - mozversion application_name: Firefox 23:17:20 INFO - mozversion application_remotingname: firefox 23:17:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:17:20 INFO - mozversion application_vendor: Mozilla 23:17:20 INFO - mozversion application_version: 51.0a1 23:17:20 INFO - mozversion platform_buildid: 20160829203012 23:17:20 INFO - mozversion platform_changeset: fecb1018cdcbf931db0892b6fba2e8348286f1d8 23:17:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:17:20 INFO - mozversion platform_version: 51.0a1 23:17:20 INFO - using testdate: 1472537840 23:17:20 INFO - actual date: 1472537840 23:17:20 INFO - starting webserver on 'localhost:33902' 23:17:20 INFO - SUITE-START | Running 2 tests 23:17:20 INFO - TEST-START | dromaeo_css 23:17:20 INFO - operating with platform_type : linux_ 23:17:20 INFO - Initialising browser for dromaeo_css test... 23:17:20 INFO - TEST-INFO | started process 25094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPKaUk/profile http://localhost:33902/getInfo.html) 23:17:25 INFO - PROCESS | 25094 | __metrics Screen width/height:1600/1200 23:17:25 INFO - PROCESS | 25094 | colorDepth:24 23:17:25 INFO - PROCESS | 25094 | Browser inner width/height: 1024/697 23:17:25 INFO - PROCESS | 25094 | __metrics 23:17:25 INFO - PROCESS | 25094 | 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" 23:17:25 INFO - PROCESS | 25094 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:26 INFO - PROCESS | 25094 | console.error: PushService: 23:17:26 INFO - PROCESS | 25094 | stateChangeProcessEnqueue: Error transitioning state 23:17:26 INFO - PROCESS | 25094 | UnknownError 23:17:26 INFO - TEST-INFO | 25094: exit 0 23:17:26 INFO - Browser initialized. 23:17:26 INFO - Running cycle 1/1 for dromaeo_css test... 23:17:26 INFO - TEST-INFO | started process 25177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPKaUk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:38 INFO - PROCESS | 25177 | RSS: Main: 180314112 23:17:38 INFO - PROCESS | 25177 | 23:18:30 INFO - PROCESS | 25177 | 1472537910391 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] 23:20:40 INFO - PROCESS | 25177 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33902/tests/dromaeo/cssquery-ext.html) 23:20:41 INFO - PROCESS | 25177 | RSS: Main: 308596736 23:20:41 INFO - PROCESS | 25177 | 23:23:43 INFO - PROCESS | 25177 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-ext.html (next: http://localhost:33902/tests/dromaeo/cssquery-jquery.html) 23:23:44 INFO - PROCESS | 25177 | RSS: Main: 279474176 23:23:44 INFO - PROCESS | 25177 | 23:26:46 INFO - PROCESS | 25177 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33902/tests/dromaeo/cssquery-mootools.html) 23:26:47 INFO - PROCESS | 25177 | RSS: Main: 249274368 23:26:47 INFO - PROCESS | 25177 | 23:29:49 INFO - PROCESS | 25177 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33902/tests/dromaeo/cssquery-prototype.html) 23:29:49 INFO - PROCESS | 25177 | RSS: Main: 259407872 23:29:49 INFO - PROCESS | 25177 | 23:32:52 INFO - PROCESS | 25177 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33902/tests/dromaeo/cssquery-yui.html) 23:32:53 INFO - PROCESS | 25177 | RSS: Main: 216092672 23:32:53 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-yui.html (next: http://localhost:33902/tests/dromaeo/cssquery-dojo.html) 23:35:56 INFO - PROCESS | 25177 | RSS: Main: 303714304 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | __start_tp_report 23:35:56 INFO - PROCESS | 25177 | _x_x_mozilla_page_load 23:35:56 INFO - PROCESS | 25177 | _x_x_mozilla_page_load_details 23:35:56 INFO - PROCESS | 25177 | |i|pagename|runs| 23:35:56 INFO - PROCESS | 25177 | |0;dojo.html;3035.8937437189697;3055.9236019099535;3060.7857449978496;3092.536119582061;3110.113617618979;5236.973815130919;5274.156135018397;5298.258243845865;5363.141897296433;5406.351237851459;5290.523852853243;5319.20211968205;5341.225522299264;5411.161270003156;5412.864678383043;4800.783964721596;4836.15367310721;4859.708417494944;4869.683470574419;4875.780589873464;4814.085323788487;4871.780769865364;4892.437369702477;4904.509549045102;4975.104481193383;4968.503149685039;5014.52362025607;5017.473165317644;5028.7988480460735;5033.572146367563;4741.525847415265;4771.37972063633;4811.39395017618;4824.98675278192;4886.242632391985;4783.617310615143;4787.353707249512;4797.904041919177;4800.231962885921;4820.807167713322;5315.149576067811;5330.333708286465;5371.435999220064;5415.431379705114;5425.267588875491;5597.496225339739;5800.8259752207505;5801.6519008859605;5852.941470585325;5873.177755114288;5751.654900705929;5765.336986246593;5774.364819869811;5822.650640961556;5826.504747096502;5360.383555891083;5415.918761218585;5417.4311697272005;5422.0511410503;5477.945220547823;5716.371199168088;5851.912221316684;5931.970340148272;5937.881242375129;5942.7920022799;5599.272094627754;5729.5702822288495;5733.655980641091;5734.225879506297;5739.483446489836;5727.971360143256;5746.597738158289;5751.223584815996;5801;5822.82531524055;5723.570732195102;5732.713364331767;5733.856653583611;5738.254026976467;5744.109663002241;5536.197251398606;5644.927463781951;5650.802221922295;5740.827775166752;5742.0238559445;4420.425344705168;4451.688381813242;4451.888702782457;4459.397981272552;4459.777011149429;4009.1981603679383;4013.8394464221105;4013.8996525086523;4014.4781178446615;4018.738781979162;5455.781768729285;5469.097598896137;5476.205950137208;5476.91784623231;5479.424660410599;5634.295713035871;5722.17028530869;5727.8568035799435;5762.711864406763;5821.2141360916585;5439.048166570834;5446.2375267462585;5447.782088716407;5448.237246785453;5451.182322651634;5000.599952003831;5008.048470790538;5008.323876276729;5013.147764879979;5066.797328106908;5824.679642619697;5875.6474611523445;5876.030454974882;5927.8221653350465;6036.547258955508;5757.798477053283;5769.884602308014;5773.220615216892;5776.480116789509;5780;5951.732172052355;5954.136650185612;5968.373320801427;5969.074793407029;5969.194158788508;5538;5569.053260945568;5591.9720401397735;5600.831975040755;5701.173329867229;5702.372738998624;5704.3725190228215;5707.743151558107;5716.056850619601;5724.313082429969;5571.1086226203615;5572.91640625399;5576.079946808731;5595.524380427709;5601.187827764869;5483.479069488392;5568.49883510486;5594.964931487688;5606.327240731139;5708.315002199596;5567.415421380697;5613.522850557585;5617.269754931833;5617.634853734494;5622.269105016322;5646.378898321099;5669.121286200645;5670.092785154356;5670.971645141748;5672.886542269214;5312.28284181646;5480.424555421783;5532.612717109924;5543.25166102571;5640.774369025357 23:35:56 INFO - PROCESS | 25177 | |1;ext.html;572.5162237908966;598.0311894730537;598.9011813050847;612.6660969771474;621.9036049412341;31746.841265793668;43553.12893742127;44529.109417811625;44628;44668.55331446689;44658;45246.773766131206;45247.77376113123;45295.09409811802;45295.77352113243;8037.196280371945;8942.105789421072;9102.681406150787;9109.271258299354;10529.578816847355;10555.630552930648;10697.625583104593;10709.518071686793;10716.571337146504;10718.571257149704;10799.67600971972;10841.186910981669;10854.24020318578;10859.457027148612;10861.40262285574;10728.624498142566;10764.13886889047;10768.73078173044;10772.892271077268;10790.838137427867;10627.84058239127;10684.19868509857;10693.893061069446;10695.572177112907;10697.572097116106;42556.78721606372;42621.36067958983;43145.56854431447;43255;43281.78359108216;3367.225538126245;3799.2211596622624;4098.877033688965;4150.460440142762;4154.50145982484;32466;32637.51043734346;32945.6705432945;32988.17529561756;33343;3720.1257704439436;3771.7925514096714;3845.038740314921;3875.3411919973673;3882.0683036071423;335034;335356;335483;335872;336614.99999999756;55955;56135;56511.43488565144;56599.43400566024;56631.43368566344;60572.697136514034;60666;60678;60765.39234607686;60796.696016519636;16498.67002659964;16716;16719.49841504757;16722.16389180536;16724.080175590218;10851.782964340828;10936.070434013198;10956.397398143179;11205.775884482264;12967.481300747864;16400.425985090464;16907.661846763243;16916.15419229058;17419.303227870998;17459.214335354685;5717.542596592262;5847;5924.763009479659;5934.308722014205;5979.252593425822;885.7785553611598;1007.3603261928581;1014.7919676466307;1035.2390992620417;1061.310148403544;29216.561751573743;31323.686763132533;31459.84270078681;31673.683263167073;31814.937026073283;1014.4065721552827;1053.9262251642465;1084.804735147681;1096.3038470571244;1133.0595605647459;15863.20683965797;16557.66884662324;16629.750553741702;16805.495835124966;16836.74744878828;478124;479561;482144;502617;731345;57786;58298.708506458046;58473;58503.70748146317;58556;1326.661701266171;1328.110166188656;1339.6048165791115;1344.771388863876;1364.4883168811696;30694.693053069182;32663.67336326606;33013.339733205685;33269.33461330712;33455.66544334526;50566.49433505765;50919;51152.48847511626;51155;51238.48761512337;429718;430235;430333;430762;432581;40488.79755601203;40900.38649420321;41133.58866411417;41214.175716486105;41399.7930010348;46166.696497822166;47558;47838.5216147848;48261.27608085952;48795.5120448791;39591.86326119456;39721.40417893792;40481.1903761929;40781.79609101936;42036;40040.799796000836;41398.47530922256;41638;42356.7643235674;42475;39677;40041.799791000856;41166.1766764657;41303.38044929389;41354.586454135075;34530;35522;36533.26933461369;36608.81695591505;36761.26477470489;25293.09129450137;25576.10711019385;25700.357491062874;25847.224583262534;26215.606765898145 23:35:56 INFO - PROCESS | 25177 | |2;jquery.html;383.22970828634436;405.90055436418083;409.063245168564;411.90114372550585;425.9275923093074;15753.527394178178;19410.51473713158;19613.901930490363;19693.21227150912;19874.602507949832;18748.250069997182;19175.13711882965;19631.60736785267;19878.900605496987;20184.495387615316;5541.224228607998;5573.913086948047;5736.885262294752;5760.107183386561;5841.269841269841;4150.9584904151025;5761;5846.50304724099;5846.561507886904;6271.560990730651;6502.804915852532;6548.410643042125;6551.737930482799;6553.836154096162;6559.3112723164095;6262.5929314594405;6408.038794180887;6432.871342573169;6432.935670643281;6542.4438922691625;5539.25220095286;5716.799912003102;5717.142428635696;5719.628224165416;5721.628094173865;23536.411589710224;23642.17252396175;23658.88170559136;23831.761682383127;23867.88066059676;2255.334676270504;2324.6164382876805;2358.4457652451833;2547.6942766868096;2779.5274803283287;14352.354144063542;14733;14788.55634330961;14950.102993820297;15308.234588270541;1834.284628994693;1894.084087808508;1924.1052910396593;1945.299692110839;1959.480737604536;74640.62679686566;82113.58943205305;82318.58840705758;83037.58481207555;85127;10966.287191332538;11024.204471055116;11249.325040497597;11395.259308144945;11594.304341739522;15991.200439977954;15994;15999.200039998186;16005;16010.359585616678;7798.610069496503;7861.2531809478005;8003.31971782405;8158.796030099295;8232.670693172206;7493.625318734042;7542.6605802739;7543.47195696307;7785.766427007199;7802.219778022152;4782.163121453801;4845.964694828181;4887.462379138292;4968.944099378856;5012.47369026247;2014.486305991992;2016.4353980885376;2043.7751847296786;2064.9793502064786;2106.8525203235627;850.9319254459629;891.6032365597376;958.7842735384482;961.6201600367956;1007.9546420411099;19192.616147676967;20094.39716808498;20094.89952550228;20392.54707828571;20519;975.7316737897135;979.6081567373108;1012.3268026762267;1014.9594016239415;1043.5251960358019;10663.360198388122;11049.889501104886;11052.336859788278;11249.550017999352;11300.886991129983;444415;456455;457083;472695;473939;89600.5519972396;91461;92061.53969230111;92303;92362;995.5221493683073;999.7750506136061;1014.2241185493103;1018.3431686562126;1028.0850043461326;16979.66040679204;17150.672983527227;17711.73432398541;17748.3788067417;17901.283948641907;42090.789546052074;42946;43221.3516797242;43602;45765;56783;57874;58022.4197758017;58186.709066454394;60034;8225.300849427626;8317.41778075529;8338.666453341799;8501.319894408309;8517.361197910057;10449.529771160163;12275.263484190977;12792.936035319764;12883.227006379648;13152.736945261233;11164.274322169033;11264.549418023187;11365.374904380338;11584.594539191088;11954.940225298818;10612.310199836986;10899.673009809718;10900.400477973788;11122.944385278022;11424.543018279175;11055.22613417053;11098.61154859576;11484.712882178012;11490.48292826808;11915.702107447036;8432.45189062709;8434.873476897728;8599.355048371272;8606.311495080503;8690.304775618062;9026.774330641523;10580.36517808934;10941.617043403443;10944.562217511211;10957.83563246536 23:35:56 INFO - PROCESS | 25177 | |3;mootools.html;1308.5093090091216;1491.5003473836264;1505.4580351073614;1561.3598424645897;1640.9097499637514;8492.405531612781;8862.113788621135;8927.375083744133;9144.405613635108;9162.541872906344;8973.685920992766;9069;9071.319651026166;9074.546272686355;9074.909250907489;2419.3104965084954;2451.6199989001734;2452.7424620414868;2454.1901172613084;2463.5688754467988;2413.6578682168674;2430.2344761400104;2445.7921076708503;2450.179189971353;2451.816113791464;2357.8682232528395;2375.4298968247667;2386.033656369173;2389.4623709665275;2410.108259943823;2331;2346.4485845826216;2375.6674065630827;2378.120095564635;2387.5941090014653;2337.544178885118;2343.6601692754457;2378.5361854438393;2378.8691621960784;2379.4408314046186;8896.688615898478;8985.191332780016;9066.68266610672;9123.543822808833;9139.360244782867;5111.284420181178;5327.786888524454;5329.733513324319;5341.706206158659;5351.1973204019705;3410.7271418286477;3428.5885693716664;3509.31568344173;3509.7016753575977;3513.385157597436;1150.4707834396188;1159.1827761428174;1163.5055101581793;1181.1908842442954;1185.419144619139;12468;12521.12352135351;12586.37068146589;12618.305993170372;12651.051171162107;4377.693561450732;4503.977480112579;4622.722636641813;4633.907321853544;4664.55686709762;9902.257330700226;9905.80188396228;9910.35582687123;9917.30578859473;9924.454155021398;5290.338707661543;5337.226102215234;5340.839774806762;5364.865878353073;5370.650907690988;4381.233284175257;4834.758262086882;4974.90050198994;4997.350344455198;5016.147254966664;3851.826667799956;3927.4501569780255;3996.18078293949;4021.2560676274984;4038.0522218780457;1217.7990631545695;1231.5258625429094;1239.535174309634;1240.6464157715009;1258.087886282438;977.2719324103589;983.9065288797552;996.5615129343066;1003.5935446144323;1007.7128018514688;5984.790532331347;6029.517638588903;6115.419035191739;6246.219222597176;6330.778422755181;946.9053094690613;970.8786401699788;980.7450062983532;1007.4610083605236;1038.1642777564134;4142.2543942090115;4263.16868210696;4281.678874084456;4336.501302350207;4388.71473354231;11208.327500350006;11586.304821710724;11610.94194529022;11616.651500455;11624.070074394029;11436.599719009795;11503.712407189887;11508.19442639024;11514.654560363202;11522.942385288019;8069;8248;8425.325973922194;8441.240288374076;8441.66233350659;6025.126356678345;6125.203723516092;6319.24169099711;6373.426391624776;6584.473242140713;10242.334248273839;10384.844227336747;10598.20513461509;10624.415657138932;10635.255532112678;10263.794724105626;10457.47712614351;10633;10759.13926885863;10781.892181078088;7257.201707812242;7978.760637180894;8143.348532117535;8217.506949583045;8531.402801803813;8560.529170895661;8887.111288871061;8887.73336799897;8891.155340242667;8895.911040889509;7562.546247225184;7639.121501027231;7642.312191902755;8002.83994320122;8070.192980701883;7409.629518523944;7463.925360746323;7607.391408687403;7643.197464266172;7777.766666999999;7103.2541583133025;7233.204347521873;7247.094113235846;7284.125904891447;7284.3808276294985;5168.224766285088;5349.732513374393;5372.677639341496;5443.564514838883;5628.296462942132;5403.162509810985;5549.750261238173;5556.555475562026;5581.441855814386;5686.459786320293 23:35:56 INFO - PROCESS | 25177 | |4;prototype.html;323.13883500471246;324.8083630657911;331.4026099184768;342.4452387132844;343.90886415100005;5054.368203974504;5074.035933172695;5173.835886925444;5248.47515248475;5261.710605916678;5039;5104.259882317062;5128.974355128219;5151.150060240066;5158.92261616076;4068.4507591475144;4072.1855628874196;4079.73481723687;4082.7142100053006;4088.589436644353;3856.014152711356;3994.3409337459284;4086.4891888513935;4087.652549533293;4088.1823635272917;4022.658074063708;4032.4757781488365;4046.109855831712;4052.412400201969;4060.741170237221;4033.6773058155277;4037.7577345359077;4039.293123703355;4047.7166598338276;4054.4121102440276;3643.981780091083;3651.1602331463914;3653.94519082214;3662.285854258421;3665.6151104133946;4953.888272733622;5076.23856421536;5092.388913330387;5093.541581257705;5100.081985242655;4705.12955103307;4707.646926480494;4719.457262414832;4726.456457507396;4727.3854398927915;5264.815731449381;5419.647722898038;5424.864378390533;5427.104527752916;5432.375276843135;3998.4402183694306;4017.0961533654986;4020.517537895442;4026;4046.291898917678;5588.038339679976;5599.544118529171;5605.495505404533;5622.971885140589;5628.296462942132;4139.089400331922;4144.378343248537;4146.647534959562;4152.896177595524;4159.272127377697;3956.940645890314;4161.9375709364385;4172.436721042621;4190.182914331737;4197.992481804345;4676.3453116563705;4682.274247491576;4684.625229981593;4699.425692393087;4699.718016918996;5444.5916556258435;5454.209139674805;5460.334597947584;5463.672179669233;5468.91796623051;1401.5865319730501;1441.2001339256603;1445.6747231872955;1455.403284653287;1462.3200211901517;931.7933276406934;937.9718608441758;947.8436058050345;956.2923436656824;956.5934477846887;4603.700759450625;4649.7210167389385;4658.86023419298;4666.556677115668;4711.199096153662;4852.636052296092;4882.414110306786;4910.8772280693265;4912.238603016538;4934.8766280843265;4495.797689103998;4670.929936050962;4684.742339171378;4685.289869197786;4706.247000479907;2595.935101622437;2627.908023219178;2627.973720262773;2628.7765539928937;2635.499255141517;5040.79836806531;5074.238864170404;5075.8223462179385;5081.74591270435;5095.4522738630685;4761.500042495488;4908.9754551227015;5000.574951129122;5011.724355160502;5014.89970200594;5019.447860735389;5041.294218809443;5054.873628159252;5059.72171530562;5061.911688986886;4895.5558110356815;4896.975515122402;4912.214045752806;4915.262710593297;4917.26241063829;4667.809708524304;4847.248676455155;4866.639679755387;4876.683015603974;4881.951180488291;4981.903981124147;4990.600751939909;5015.648904576645;5019.7490125494305;5062.797488100582;3722.9813850931655;3750.887473375803;3763.776772548987;3888.475055867535;3939;5457.890842183214;5457.918131228114;5461.15352120422;5466.398696143341;5479.178123281539;5339.4126646068125;5353.304070470814;5370.301860758233;5382.542483888913;5383.569314454756;5185;5328.893422131613;5364.275822764033;5369.946300537101;5373.11343628297;5361.276227709365;5365.678059316453;5366.692322301448;5368.892622147613;5377.24718539397;5417.214503896992;5418.241446197614;5420.7289635518855;5425;5433.320834895638;5071.123684236856;5257.2902658140665;5283.365996080495;5302.28419163408;5308.522232999048 23:35:56 INFO - PROCESS | 25177 | |5;yui.html;737.3216640690565;743.1936349061268;763.8166839958411;789.9881501777471;796.6773456750018;14046.297685115742;16531.421400250994;17581.384651537184;17581.472555823315;18301.54246143844;15679.60800979976;15740.212989350515;15751.527454176365;15763.054216746974;15766.448174313902;792.2671528835832;813.9715109971153;817.2603793566832;818.378032695153;818.8034871630796;654.6301339743054;770.3182683325241;786.9291763741262;795.916428774979;799.2966189753038;853.5390888920007;854.2909385210261;854.9187827156442;855.5209082913557;856.1737922904396;675.8242856857204;853.2875049333813;853.2960307746134;853.5305581929945;853.8889944307232;591.2254946020727;604.0003793721398;607.171211296577;609.5337067143639;610.1610285856947;13990.370433330525;14024.158550487004;14394.640133996629;14426.927865360605;14455.060421072596;14523.636909077251;14678.412863485448;14990.700185996327;15159.545213643498;15276.159811210378;13075.86924130756;13399.665008374772;13518;13831.861681383158;13834.446622135103;4614.723116613014;4648.140094082605;4670.252759558454;4870.366852309213;4878.902421951577;80933;81110.59444702798;82321.58839205766;87666;90435;11619.477123529461;11752.294862308288;11811;12101.75796484083;12485.563005294953;22129.889350553465;22135.667964980537;22141.335759927228;22202.555948881254;22304.442388940082;8689.86017288263;8700.30397568193;8762.605682744292;8762.693305734269;9124.361294709306;4725.10223057618;4746.691465054761;4778.402699662543;4835.734034628129;4891.192953162688;3437.432823584131;3532.4701294805986;3547.4856145858707;3550.396432606463;3550.786952782841;579.4607850408207;583.813179782474;583.8410754652012;588.8410129265075;605.8545948972215;654.8493846415352;655.2530115668142;712.989305160423;719.1478098453349;728.2717282717283;9535.761605959906;9743.512824358753;9902.455364954996;10039.69880903574;10299.639512617023;559.9445046088072;573.8766563714274;666.0808084842982;708.5512409570388;753.6004527559971;4726.763661816895;5344.3853956795465;5513.09034009392;5528.889422211533;5540.861478463071;106978;113691;119073;121105;121883;101318.49340753249;102230;103336.48331758293;109105;111152;92959;93444.53277733568;95225;95927.52036239774;96963;10046.54790534413;10314.845277320695;10329.586816527555;10349.778190651765;10464;50721.492785073155;50820.49179508157;51343.74328128336;51563.48436515737;53848;75482.62258688672;77521.61239193768;79227;81713.59143204246;82178.58910705408;12620.242785432903;13246.072774905664;13254.403551839998;13315.733685326046;13632.863671363557;15215.77176342378;15377.461788837338;15649.974759717363;15896.205189740698;16801.495955121365;13631.318434078456;14316.785248221493;14337.354819033377;14624.561263162122;14950.476733314283;13773.38019789132;13788;13817.79273310881;13855.237961912191;14767.556973290819;14442.566722998326;14445.910944834191;14657.853421465648;14814.555563333117;14950.626234344229;11187.552497899993;11371.67613975101;11655.417229138679;11774.470148843151;12168.452419641315;11751.88248117542;11847.35067939584;11896.881031189578;11897.940510297392;12060.879391206327 23:35:56 INFO - PROCESS | 25177 | __end_tp_report 23:35:56 INFO - PROCESS | 25177 | __start_cc_report 23:35:56 INFO - PROCESS | 25177 | _x_x_mozilla_cycle_collect,1012 23:35:56 INFO - PROCESS | 25177 | __end_cc_report 23:35:56 INFO - PROCESS | 25177 | __startTimestamp1472538956407__endTimestamp 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | ------- Summary: start ------- 23:35:56 INFO - PROCESS | 25177 | Number of tests: 6 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | [#0] dojo.html Cycles:165 Average:5340.97 Median:5567.42 stddev:602.16 (10.8%) stddev-sans-first:576.22 23:35:56 INFO - PROCESS | 25177 | Values: 3035.9 3055.9 3060.8 3092.5 3110.1 5237.0 5274.2 5298.3 5363.1 5406.4 5290.5 5319.2 5341.2 5411.2 5412.9 4800.8 4836.2 4859.7 4869.7 4875.8 4814.1 4871.8 4892.4 4904.5 4975.1 4968.5 5014.5 5017.5 5028.8 5033.6 4741.5 4771.4 4811.4 4825.0 4886.2 4783.6 4787.4 4797.9 4800.2 4820.8 5315.1 5330.3 5371.4 5415.4 5425.3 5597.5 5800.8 5801.7 5852.9 5873.2 5751.7 5765.3 5774.4 5822.7 5826.5 5360.4 5415.9 5417.4 5422.1 5477.9 5716.4 5851.9 5932.0 5937.9 5942.8 5599.3 5729.6 5733.7 5734.2 5739.5 5728.0 5746.6 5751.2 5801.0 5822.8 5723.6 5732.7 5733.9 5738.3 5744.1 5536.2 5644.9 5650.8 5740.8 5742.0 4420.4 4451.7 4451.9 4459.4 4459.8 4009.2 4013.8 4013.9 4014.5 4018.7 5455.8 5469.1 5476.2 5476.9 5479.4 5634.3 5722.2 5727.9 5762.7 5821.2 5439.0 5446.2 5447.8 5448.2 5451.2 5000.6 5008.0 5008.3 5013.1 5066.8 5824.7 5875.6 5876.0 5927.8 6036.5 5757.8 5769.9 5773.2 5776.5 5780.0 5951.7 5954.1 5968.4 5969.1 5969.2 5538.0 5569.1 5592.0 5600.8 5701.2 5702.4 5704.4 5707.7 5716.1 5724.3 5571.1 5572.9 5576.1 5595.5 5601.2 5483.5 5568.5 5595.0 5606.3 5708.3 5567.4 5613.5 5617.3 5617.6 5622.3 5646.4 5669.1 5670.1 5671.0 5672.9 5312.3 5480.4 5532.6 5543.3 5640.8 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | [#1] ext.html Cycles:180 Average:59964.77 Median:3860.19 stddev:118018.53 (3057.3%) stddev-sans-first:118265.36 23:35:56 INFO - PROCESS | 25177 | Values: 572.5 598.0 598.9 612.7 621.9 31746.8 43553.1 44529.1 44628.0 44668.6 44658.0 45246.8 45247.8 45295.1 45295.8 8037.2 8942.1 9102.7 9109.3 10529.6 10555.6 10697.6 10709.5 10716.6 10718.6 10799.7 10841.2 10854.2 10859.5 10861.4 10728.6 10764.1 10768.7 10772.9 10790.8 10627.8 10684.2 10693.9 10695.6 10697.6 42556.8 42621.4 43145.6 43255.0 43281.8 3367.2 3799.2 4098.9 4150.5 4154.5 32466.0 32637.5 32945.7 32988.2 33343.0 3720.1 3771.8 3845.0 3875.3 3882.1 335034.0 335356.0 335483.0 335872.0 336615.0 55955.0 56135.0 56511.4 56599.4 56631.4 60572.7 60666.0 60678.0 60765.4 60796.7 16498.7 16716.0 16719.5 16722.2 16724.1 10851.8 10936.1 10956.4 11205.8 12967.5 16400.4 16907.7 16916.2 17419.3 17459.2 5717.5 5847.0 5924.8 5934.3 5979.3 885.8 1007.4 1014.8 1035.2 1061.3 29216.6 31323.7 31459.8 31673.7 31814.9 1014.4 1053.9 1084.8 1096.3 1133.1 15863.2 16557.7 16629.8 16805.5 16836.7 478124.0 479561.0 482144.0 502617.0 731345.0 57786.0 58298.7 58473.0 58503.7 58556.0 1326.7 1328.1 1339.6 1344.8 1364.5 30694.7 32663.7 33013.3 33269.3 33455.7 50566.5 50919.0 51152.5 51155.0 51238.5 429718.0 430235.0 430333.0 430762.0 432581.0 40488.8 40900.4 41133.6 41214.2 41399.8 46166.7 47558.0 47838.5 48261.3 48795.5 39591.9 39721.4 40481.2 40781.8 42036.0 40040.8 41398.5 41638.0 42356.8 42475.0 39677.0 40041.8 41166.2 41303.4 41354.6 34530.0 35522.0 36533.3 36608.8 36761.3 25293.1 25576.1 25700.4 25847.2 26215.6 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | [#2] jquery.html Cycles:180 Average:28395.70 Median:1581.38 stddev:76172.68 (4816.9%) stddev-sans-first:76357.33 23:35:56 INFO - PROCESS | 25177 | Values: 383.2 405.9 409.1 411.9 425.9 15753.5 19410.5 19613.9 19693.2 19874.6 18748.3 19175.1 19631.6 19878.9 20184.5 5541.2 5573.9 5736.9 5760.1 5841.3 4151.0 5761.0 5846.5 5846.6 6271.6 6502.8 6548.4 6551.7 6553.8 6559.3 6262.6 6408.0 6432.9 6432.9 6542.4 5539.3 5716.8 5717.1 5719.6 5721.6 23536.4 23642.2 23658.9 23831.8 23867.9 2255.3 2324.6 2358.4 2547.7 2779.5 14352.4 14733.0 14788.6 14950.1 15308.2 1834.3 1894.1 1924.1 1945.3 1959.5 74640.6 82113.6 82318.6 83037.6 85127.0 10966.3 11024.2 11249.3 11395.3 11594.3 15991.2 15994.0 15999.2 16005.0 16010.4 7798.6 7861.3 8003.3 8158.8 8232.7 7493.6 7542.7 7543.5 7785.8 7802.2 4782.2 4846.0 4887.5 4968.9 5012.5 2014.5 2016.4 2043.8 2065.0 2106.9 850.9 891.6 958.8 961.6 1008.0 19192.6 20094.4 20094.9 20392.5 20519.0 975.7 979.6 1012.3 1015.0 1043.5 10663.4 11049.9 11052.3 11249.6 11300.9 444415.0 456455.0 457083.0 472695.0 473939.0 89600.6 91461.0 92061.5 92303.0 92362.0 995.5 999.8 1014.2 1018.3 1028.1 16979.7 17150.7 17711.7 17748.4 17901.3 42090.8 42946.0 43221.4 43602.0 45765.0 56783.0 57874.0 58022.4 58186.7 60034.0 8225.3 8317.4 8338.7 8501.3 8517.4 10449.5 12275.3 12792.9 12883.2 13152.7 11164.3 11264.5 11365.4 11584.6 11954.9 10612.3 10899.7 10900.4 11122.9 11424.5 11055.2 11098.6 11484.7 11490.5 11915.7 8432.5 8434.9 8599.4 8606.3 8690.3 9026.8 10580.4 10941.6 10944.6 10957.8 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | [#3] mootools.html Cycles:180 Average:5955.17 Median:4904.83 stddev:3394.52 (69.2%) stddev-sans-first:3386.08 23:35:56 INFO - PROCESS | 25177 | Values: 1308.5 1491.5 1505.5 1561.4 1640.9 8492.4 8862.1 8927.4 9144.4 9162.5 8973.7 9069.0 9071.3 9074.5 9074.9 2419.3 2451.6 2452.7 2454.2 2463.6 2413.7 2430.2 2445.8 2450.2 2451.8 2357.9 2375.4 2386.0 2389.5 2410.1 2331.0 2346.4 2375.7 2378.1 2387.6 2337.5 2343.7 2378.5 2378.9 2379.4 8896.7 8985.2 9066.7 9123.5 9139.4 5111.3 5327.8 5329.7 5341.7 5351.2 3410.7 3428.6 3509.3 3509.7 3513.4 1150.5 1159.2 1163.5 1181.2 1185.4 12468.0 12521.1 12586.4 12618.3 12651.1 4377.7 4504.0 4622.7 4633.9 4664.6 9902.3 9905.8 9910.4 9917.3 9924.5 5290.3 5337.2 5340.8 5364.9 5370.7 4381.2 4834.8 4974.9 4997.4 5016.1 3851.8 3927.5 3996.2 4021.3 4038.1 1217.8 1231.5 1239.5 1240.6 1258.1 977.3 983.9 996.6 1003.6 1007.7 5984.8 6029.5 6115.4 6246.2 6330.8 946.9 970.9 980.7 1007.5 1038.2 4142.3 4263.2 4281.7 4336.5 4388.7 11208.3 11586.3 11610.9 11616.7 11624.1 11436.6 11503.7 11508.2 11514.7 11522.9 8069.0 8248.0 8425.3 8441.2 8441.7 6025.1 6125.2 6319.2 6373.4 6584.5 10242.3 10384.8 10598.2 10624.4 10635.3 10263.8 10457.5 10633.0 10759.1 10781.9 7257.2 7978.8 8143.3 8217.5 8531.4 8560.5 8887.1 8887.7 8891.2 8895.9 7562.5 7639.1 7642.3 8002.8 8070.2 7409.6 7463.9 7607.4 7643.2 7777.8 7103.3 7233.2 7247.1 7284.1 7284.4 5168.2 5349.7 5372.7 5443.6 5628.3 5403.2 5549.8 5556.6 5581.4 5686.5 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | [#4] prototype.html Cycles:180 Average:4408.85 Median:4909.93 stddev:1243.95 (25.3%) stddev-sans-first:1209.05 23:35:56 INFO - PROCESS | 25177 | Values: 323.1 324.8 331.4 342.4 343.9 5054.4 5074.0 5173.8 5248.5 5261.7 5039.0 5104.3 5129.0 5151.2 5158.9 4068.5 4072.2 4079.7 4082.7 4088.6 3856.0 3994.3 4086.5 4087.7 4088.2 4022.7 4032.5 4046.1 4052.4 4060.7 4033.7 4037.8 4039.3 4047.7 4054.4 3644.0 3651.2 3653.9 3662.3 3665.6 4953.9 5076.2 5092.4 5093.5 5100.1 4705.1 4707.6 4719.5 4726.5 4727.4 5264.8 5419.6 5424.9 5427.1 5432.4 3998.4 4017.1 4020.5 4026.0 4046.3 5588.0 5599.5 5605.5 5623.0 5628.3 4139.1 4144.4 4146.6 4152.9 4159.3 3956.9 4161.9 4172.4 4190.2 4198.0 4676.3 4682.3 4684.6 4699.4 4699.7 5444.6 5454.2 5460.3 5463.7 5468.9 1401.6 1441.2 1445.7 1455.4 1462.3 931.8 938.0 947.8 956.3 956.6 4603.7 4649.7 4658.9 4666.6 4711.2 4852.6 4882.4 4910.9 4912.2 4934.9 4495.8 4670.9 4684.7 4685.3 4706.2 2595.9 2627.9 2628.0 2628.8 2635.5 5040.8 5074.2 5075.8 5081.7 5095.5 4761.5 4909.0 5000.6 5011.7 5014.9 5019.4 5041.3 5054.9 5059.7 5061.9 4895.6 4897.0 4912.2 4915.3 4917.3 4667.8 4847.2 4866.6 4876.7 4882.0 4981.9 4990.6 5015.6 5019.7 5062.8 3723.0 3750.9 3763.8 3888.5 3939.0 5457.9 5457.9 5461.2 5466.4 5479.2 5339.4 5353.3 5370.3 5382.5 5383.6 5185.0 5328.9 5364.3 5369.9 5373.1 5361.3 5365.7 5366.7 5368.9 5377.2 5417.2 5418.2 5420.7 5425.0 5433.3 5071.1 5257.3 5283.4 5302.3 5308.5 23:35:56 INFO - PROCESS | 25177 | 23:35:56 INFO - PROCESS | 25177 | [#5] yui.html Cycles:180 Average:21976.88 Median:3550.59 stddev:31685.58 (892.4%) stddev-sans-first:31734.33 23:35:56 INFO - PROCESS | 25177 | Values: 737.3 743.2 763.8 790.0 796.7 14046.3 16531.4 17581.4 17581.5 18301.5 15679.6 15740.2 15751.5 15763.1 15766.4 792.3 814.0 817.3 818.4 818.8 654.6 770.3 786.9 795.9 799.3 853.5 854.3 854.9 855.5 856.2 675.8 853.3 853.3 853.5 853.9 591.2 604.0 607.2 609.5 610.2 13990.4 14024.2 14394.6 14426.9 14455.1 14523.6 14678.4 14990.7 15159.5 15276.2 13075.9 13399.7 13518.0 13831.9 13834.4 4614.7 4648.1 4670.3 4870.4 4878.9 80933.0 81110.6 82321.6 87666.0 90435.0 11619.5 11752.3 11811.0 12101.8 12485.6 22129.9 22135.7 22141.3 22202.6 22304.4 8689.9 8700.3 8762.6 8762.7 9124.4 4725.1 4746.7 4778.4 4835.7 4891.2 3437.4 3532.5 3547.5 3550.4 3550.8 579.5 583.8 583.8 588.8 605.9 654.8 655.3 713.0 719.1 728.3 9535.8 9743.5 9902.5 10039.7 10299.6 559.9 573.9 666.1 708.6 753.6 4726.8 5344.4 5513.1 5528.9 5540.9 106978.0 113691.0 119073.0 121105.0 121883.0 101318.5 102230.0 103336.5 109105.0 111152.0 92959.0 93444.5 95225.0 95927.5 96963.0 10046.5 10314.8 10329.6 10349.8 10464.0 50721.5 50820.5 51343.7 51563.5 53848.0 75482.6 77521.6 79227.0 81713.6 82178.6 12620.2 13246.1 13254.4 13315.7 13632.9 15215.8 15377.5 15650.0 15896.2 16801.5 13631.3 14316.8 14337.4 14624.6 14950.5 13773.4 13788.0 13817.8 13855.2 14767.6 14442.6 14445.9 14657.9 14814.6 14950.6 11187.6 11371.7 11655.4 11774.5 12168.5 11751.9 11847.4 11896.9 11897.9 12060.9 23:35:56 INFO - PROCESS | 25177 | -------- Summary: end -------- 23:35:56 INFO - PROCESS | 25177 | 23:35:57 INFO - TEST-INFO | 25177: exit 0 23:35:57 INFO - TEST-OK | dromaeo_css | took 1116540ms 23:35:57 INFO - TEST-START | kraken 23:35:57 INFO - operating with platform_type : linux_ 23:35:57 INFO - Initialising browser for kraken test... 23:35:57 INFO - TEST-INFO | started process 25479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdmzlcu/profile http://localhost:33902/getInfo.html) 23:36:01 INFO - PROCESS | 25479 | __metrics Screen width/height:1600/1200 23:36:01 INFO - PROCESS | 25479 | colorDepth:24 23:36:01 INFO - PROCESS | 25479 | Browser inner width/height: 1024/697 23:36:01 INFO - PROCESS | 25479 | __metrics 23:36:01 INFO - PROCESS | 25479 | 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" 23:36:01 INFO - PROCESS | 25479 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:36:02 INFO - PROCESS | 25479 | console.error: PushService: 23:36:02 INFO - PROCESS | 25479 | stateChangeProcessEnqueue: Error transitioning state 23:36:02 INFO - PROCESS | 25479 | UnknownError 23:36:03 INFO - TEST-INFO | 25479: exit 0 23:36:03 INFO - Browser initialized. 23:36:03 INFO - Running cycle 1/1 for kraken test... 23:36:03 INFO - TEST-INFO | started process 25562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdmzlcu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:15 INFO - PROCESS | 25562 | RSS: Main: 179896320 23:36:15 INFO - PROCESS | 25562 | 23:36:17 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:18 INFO - PROCESS | 25562 | RSS: Main: 242163712 23:36:18 INFO - PROCESS | 25562 | 23:36:21 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-dft) 23:36:21 INFO - PROCESS | 25562 | RSS: Main: 223793152 23:36:21 INFO - PROCESS | 25562 | 23:36:24 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-fft) 23:36:25 INFO - PROCESS | 25562 | RSS: Main: 300314624 23:36:25 INFO - PROCESS | 25562 | 23:36:27 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-oscillator) 23:36:28 INFO - PROCESS | 25562 | RSS: Main: 211484672 23:36:28 INFO - PROCESS | 25562 | 23:36:30 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:30 INFO - PROCESS | 25562 | RSS: Main: 213794816 23:36:30 INFO - PROCESS | 25562 | 23:36:33 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33902/tests/kraken/driver.html?testName=imaging-darkroom) 23:36:34 INFO - PROCESS | 25562 | RSS: Main: 251994112 23:36:34 INFO - PROCESS | 25562 | 23:36:37 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33902/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:38 INFO - PROCESS | 25562 | RSS: Main: 252059648 23:36:38 INFO - PROCESS | 25562 | 23:36:41 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33902/tests/kraken/driver.html?testName=json-parse-financial) 23:36:41 INFO - PROCESS | 25562 | RSS: Main: 250679296 23:36:41 INFO - PROCESS | 25562 | 23:36:43 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:36:43 INFO - PROCESS | 25562 | RSS: Main: 213028864 23:36:43 INFO - PROCESS | 25562 | 23:36:45 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:36:46 INFO - PROCESS | 25562 | RSS: Main: 219430912 23:36:46 INFO - PROCESS | 25562 | 23:36:48 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:36:49 INFO - PROCESS | 25562 | RSS: Main: 222498816 23:36:49 INFO - PROCESS | 25562 | 23:36:51 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:36:52 INFO - PROCESS | 25562 | RSS: Main: 222916608 23:36:52 INFO - PROCESS | 25562 | 23:36:55 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:55 INFO - PROCESS | 25562 | RSS: Main: 220553216 23:36:55 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33902/tests/kraken/driver.html?testName=ai-astar) 23:36:57 INFO - PROCESS | 25562 | RSS: Main: 272048128 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | __start_tp_report 23:36:57 INFO - PROCESS | 25562 | _x_x_mozilla_page_load 23:36:57 INFO - PROCESS | 25562 | _x_x_mozilla_page_load_details 23:36:57 INFO - PROCESS | 25562 | |i|pagename|runs| 23:36:57 INFO - PROCESS | 25562 | |0;ai-astar;112;111;131;111;119;111;113;112;111;111 23:36:57 INFO - PROCESS | 25562 | |1;audio-beat-detection;146;122;143;182;121;144;150;121;170;120 23:36:57 INFO - PROCESS | 25562 | |2;audio-dft;161;160;160;159;158;162;161;162;162;163 23:36:57 INFO - PROCESS | 25562 | |3;audio-fft;73;74;76;173;77;75;75;78;169;77 23:36:57 INFO - PROCESS | 25562 | |4;audio-oscillator;82;83;160;82;81;81;146;81;82;140 23:36:57 INFO - PROCESS | 25562 | |5;imaging-gaussian-blur;117;116;116;116;116;116;116;117;116;116 23:36:57 INFO - PROCESS | 25562 | |6;imaging-darkroom;146;145;147;146;146;148;147;146;147;146 23:36:57 INFO - PROCESS | 25562 | |7;imaging-desaturate;96;95;95;95;95;95;94;95;95;95 23:36:57 INFO - PROCESS | 25562 | |8;json-parse-financial;54;54;55;53;54;54;54;53;55;54 23:36:57 INFO - PROCESS | 25562 | |9;json-stringify-tinderbox;61;62;62;62;62;61;63;61;63;62 23:36:57 INFO - PROCESS | 25562 | |10;stanford-crypto-aes;85;85;87;81;82;84;78;86;84;78 23:36:57 INFO - PROCESS | 25562 | |11;stanford-crypto-ccm;136;127;137;130;123;130;131;124;166;125 23:36:57 INFO - PROCESS | 25562 | |12;stanford-crypto-pbkdf2;165;164;163;161;163;164;161;161;165;162 23:36:57 INFO - PROCESS | 25562 | |13;stanford-crypto-sha256-iterative;68;64;66;65;64;66;65;63;68;64 23:36:57 INFO - PROCESS | 25562 | __end_tp_report 23:36:57 INFO - PROCESS | 25562 | __start_cc_report 23:36:57 INFO - PROCESS | 25562 | _x_x_mozilla_cycle_collect,1693 23:36:57 INFO - PROCESS | 25562 | __end_cc_report 23:36:57 INFO - PROCESS | 25562 | __startTimestamp1472539017537__endTimestamp 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | ------- Summary: start ------- 23:36:57 INFO - PROCESS | 25562 | Number of tests: 14 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#0] ai-astar Cycles:10 Average:114.20 Median:112.00 stddev:6.39 (5.7%) stddev-sans-first:6.73 23:36:57 INFO - PROCESS | 25562 | Values: 112.0 111.0 131.0 111.0 119.0 111.0 113.0 112.0 111.0 111.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:145.00 stddev:21.69 (15.0%) stddev-sans-first:22.96 23:36:57 INFO - PROCESS | 25562 | Values: 146.0 122.0 143.0 182.0 121.0 144.0 150.0 121.0 170.0 120.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.50 stddev:1.55 (1.0%) stddev-sans-first:1.64 23:36:57 INFO - PROCESS | 25562 | Values: 161.0 160.0 160.0 159.0 158.0 162.0 161.0 162.0 162.0 163.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:40.25 (53.3%) stddev-sans-first:41.92 23:36:57 INFO - PROCESS | 25562 | Values: 73.0 74.0 76.0 173.0 77.0 75.0 75.0 78.0 169.0 77.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:81.50 stddev:32.71 (40.1%) stddev-sans-first:33.90 23:36:57 INFO - PROCESS | 25562 | Values: 82.0 83.0 160.0 82.0 81.0 81.0 146.0 81.0 82.0 140.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:36:57 INFO - PROCESS | 25562 | Values: 117.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 116.0 116.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 23:36:57 INFO - PROCESS | 25562 | Values: 146.0 145.0 147.0 146.0 146.0 148.0 147.0 146.0 147.0 146.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 23:36:57 INFO - PROCESS | 25562 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 23:36:57 INFO - PROCESS | 25562 | Values: 54.0 54.0 55.0 53.0 54.0 54.0 54.0 53.0 55.0 54.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 23:36:57 INFO - PROCESS | 25562 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 63.0 61.0 63.0 62.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.50 stddev:3.16 (3.7%) stddev-sans-first:3.27 23:36:57 INFO - PROCESS | 25562 | Values: 85.0 85.0 87.0 81.0 82.0 84.0 78.0 86.0 84.0 78.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:130.50 stddev:12.55 (9.6%) stddev-sans-first:13.26 23:36:57 INFO - PROCESS | 25562 | Values: 136.0 127.0 137.0 130.0 123.0 130.0 131.0 124.0 166.0 125.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:1.60 (1.0%) stddev-sans-first:1.50 23:36:57 INFO - PROCESS | 25562 | Values: 165.0 164.0 163.0 161.0 163.0 164.0 161.0 161.0 165.0 162.0 23:36:57 INFO - PROCESS | 25562 | 23:36:57 INFO - PROCESS | 25562 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.70 (2.6%) stddev-sans-first:1.50 23:36:57 INFO - PROCESS | 25562 | Values: 68.0 64.0 66.0 65.0 64.0 66.0 65.0 63.0 68.0 64.0 23:36:57 INFO - PROCESS | 25562 | -------- Summary: end -------- 23:36:57 INFO - PROCESS | 25562 | 23:36:58 INFO - TEST-INFO | 25562: exit 0 23:36:58 INFO - TEST-OK | kraken | took 61411ms 23:36:58 INFO - SUITE-END | took 1177s 23:36:59 INFO - Completed test suite (00:19:38) 23:36:59 INFO - javascript benchmark 23:36:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.8937437189697, 3055.9236019099535, 3060.7857449978496, 3092.536119582061, 3110.113617618979, 5236.973815130919, 5274.156135018397, 5298.258243845865, 5363.141897296433, 5406.351237851459, 5290.523852853243, 5319.20211968205, 5341.225522299264, 5411.161270003156, 5412.864678383043, 4800.783964721596, 4836.15367310721, 4859.708417494944, 4869.683470574419, 4875.780589873464, 4814.085323788487, 4871.780769865364, 4892.437369702477, 4904.509549045102, 4975.104481193383, 4968.503149685039, 5014.52362025607, 5017.473165317644, 5028.7988480460735, 5033.572146367563, 4741.525847415265, 4771.37972063633, 4811.39395017618, 4824.98675278192, 4886.242632391985, 4783.617310615143, 4787.353707249512, 4797.904041919177, 4800.231962885921, 4820.807167713322, 5315.149576067811, 5330.333708286465, 5371.435999220064, 5415.431379705114, 5425.267588875491, 5597.496225339739, 5800.8259752207505, 5801.6519008859605, 5852.941470585325, 5873.177755114288, 5751.654900705929, 5765.336986246593, 5774.364819869811, 5822.650640961556, 5826.504747096502, 5360.383555891083, 5415.918761218585, 5417.4311697272005, 5422.0511410503, 5477.945220547823, 5716.371199168088, 5851.912221316684, 5931.970340148272, 5937.881242375129, 5942.7920022799, 5599.272094627754, 5729.5702822288495, 5733.655980641091, 5734.225879506297, 5739.483446489836, 5727.971360143256, 5746.597738158289, 5751.223584815996, 5801.0, 5822.82531524055, 5723.570732195102, 5732.713364331767, 5733.856653583611, 5738.254026976467, 5744.109663002241, 5536.197251398606, 5644.927463781951, 5650.802221922295, 5740.827775166752, 5742.0238559445, 4420.425344705168, 4451.688381813242, 4451.888702782457, 4459.397981272552, 4459.777011149429, 4009.1981603679383, 4013.8394464221105, 4013.8996525086523, 4014.4781178446615, 4018.738781979162, 5455.781768729285, 5469.097598896137, 5476.205950137208, 5476.91784623231, 5479.424660410599, 5634.295713035871, 5722.17028530869, 5727.8568035799435, 5762.711864406763, 5821.2141360916585, 5439.048166570834, 5446.2375267462585, 5447.782088716407, 5448.237246785453, 5451.182322651634, 5000.599952003831, 5008.048470790538, 5008.323876276729, 5013.147764879979, 5066.797328106908, 5824.679642619697, 5875.6474611523445, 5876.030454974882, 5927.8221653350465, 6036.547258955508, 5757.798477053283, 5769.884602308014, 5773.220615216892, 5776.480116789509, 5780.0, 5951.732172052355, 5954.136650185612, 5968.373320801427, 5969.074793407029, 5969.194158788508, 5538.0, 5569.053260945568, 5591.9720401397735, 5600.831975040755, 5701.173329867229, 5702.372738998624, 5704.3725190228215, 5707.743151558107, 5716.056850619601, 5724.313082429969, 5571.1086226203615, 5572.91640625399, 5576.079946808731, 5595.524380427709, 5601.187827764869, 5483.479069488392, 5568.49883510486, 5594.964931487688, 5606.327240731139, 5708.315002199596, 5567.415421380697, 5613.522850557585, 5617.269754931833, 5617.634853734494, 5622.269105016322, 5646.378898321099, 5669.121286200645, 5670.092785154356, 5670.971645141748, 5672.886542269214, 5312.28284181646, 5480.424555421783, 5532.612717109924, 5543.25166102571, 5640.774369025357], "value": 5300.335794440465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5162237908966, 598.0311894730537, 598.9011813050847, 612.6660969771474, 621.9036049412341, 31746.841265793668, 43553.12893742127, 44529.109417811625, 44628.0, 44668.55331446689, 44658.0, 45246.773766131206, 45247.77376113123, 45295.09409811802, 45295.77352113243, 8037.196280371945, 8942.105789421072, 9102.681406150787, 9109.271258299354, 10529.578816847355, 10555.630552930648, 10697.625583104593, 10709.518071686793, 10716.571337146504, 10718.571257149704, 10799.67600971972, 10841.186910981669, 10854.24020318578, 10859.457027148612, 10861.40262285574, 10728.624498142566, 10764.13886889047, 10768.73078173044, 10772.892271077268, 10790.838137427867, 10627.84058239127, 10684.19868509857, 10693.893061069446, 10695.572177112907, 10697.572097116106, 42556.78721606372, 42621.36067958983, 43145.56854431447, 43255.0, 43281.78359108216, 3367.225538126245, 3799.2211596622624, 4098.877033688965, 4150.460440142762, 4154.50145982484, 32466.0, 32637.51043734346, 32945.6705432945, 32988.17529561756, 33343.0, 3720.1257704439436, 3771.7925514096714, 3845.038740314921, 3875.3411919973673, 3882.0683036071423, 335034.0, 335356.0, 335483.0, 335872.0, 336614.99999999756, 55955.0, 56135.0, 56511.43488565144, 56599.43400566024, 56631.43368566344, 60572.697136514034, 60666.0, 60678.0, 60765.39234607686, 60796.696016519636, 16498.67002659964, 16716.0, 16719.49841504757, 16722.16389180536, 16724.080175590218, 10851.782964340828, 10936.070434013198, 10956.397398143179, 11205.775884482264, 12967.481300747864, 16400.425985090464, 16907.661846763243, 16916.15419229058, 17419.303227870998, 17459.214335354685, 5717.542596592262, 5847.0, 5924.763009479659, 5934.308722014205, 5979.252593425822, 885.7785553611598, 1007.3603261928581, 1014.7919676466307, 1035.2390992620417, 1061.310148403544, 29216.561751573743, 31323.686763132533, 31459.84270078681, 31673.683263167073, 31814.937026073283, 1014.4065721552827, 1053.9262251642465, 1084.804735147681, 1096.3038470571244, 1133.0595605647459, 15863.20683965797, 16557.66884662324, 16629.750553741702, 16805.495835124966, 16836.74744878828, 478124.0, 479561.0, 482144.0, 502617.0, 731345.0, 57786.0, 58298.708506458046, 58473.0, 58503.70748146317, 58556.0, 1326.661701266171, 1328.110166188656, 1339.6048165791115, 1344.771388863876, 1364.4883168811696, 30694.693053069182, 32663.67336326606, 33013.339733205685, 33269.33461330712, 33455.66544334526, 50566.49433505765, 50919.0, 51152.48847511626, 51155.0, 51238.48761512337, 429718.0, 430235.0, 430333.0, 430762.0, 432581.0, 40488.79755601203, 40900.38649420321, 41133.58866411417, 41214.175716486105, 41399.7930010348, 46166.696497822166, 47558.0, 47838.5216147848, 48261.27608085952, 48795.5120448791, 39591.86326119456, 39721.40417893792, 40481.1903761929, 40781.79609101936, 42036.0, 40040.799796000836, 41398.47530922256, 41638.0, 42356.7643235674, 42475.0, 39677.0, 40041.799791000856, 41166.1766764657, 41303.38044929389, 41354.586454135075, 34530.0, 35522.0, 36533.26933461369, 36608.81695591505, 36761.26477470489, 25293.09129450137, 25576.10711019385, 25700.357491062874, 25847.224583262534, 26215.606765898145], "value": 20365.99416915943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.22970828634436, 405.90055436418083, 409.063245168564, 411.90114372550585, 425.9275923093074, 15753.527394178178, 19410.51473713158, 19613.901930490363, 19693.21227150912, 19874.602507949832, 18748.250069997182, 19175.13711882965, 19631.60736785267, 19878.900605496987, 20184.495387615316, 5541.224228607998, 5573.913086948047, 5736.885262294752, 5760.107183386561, 5841.269841269841, 4150.9584904151025, 5761.0, 5846.50304724099, 5846.561507886904, 6271.560990730651, 6502.804915852532, 6548.410643042125, 6551.737930482799, 6553.836154096162, 6559.3112723164095, 6262.5929314594405, 6408.038794180887, 6432.871342573169, 6432.935670643281, 6542.4438922691625, 5539.25220095286, 5716.799912003102, 5717.142428635696, 5719.628224165416, 5721.628094173865, 23536.411589710224, 23642.17252396175, 23658.88170559136, 23831.761682383127, 23867.88066059676, 2255.334676270504, 2324.6164382876805, 2358.4457652451833, 2547.6942766868096, 2779.5274803283287, 14352.354144063542, 14733.0, 14788.55634330961, 14950.102993820297, 15308.234588270541, 1834.284628994693, 1894.084087808508, 1924.1052910396593, 1945.299692110839, 1959.480737604536, 74640.62679686566, 82113.58943205305, 82318.58840705758, 83037.58481207555, 85127.0, 10966.287191332538, 11024.204471055116, 11249.325040497597, 11395.259308144945, 11594.304341739522, 15991.200439977954, 15994.0, 15999.200039998186, 16005.0, 16010.359585616678, 7798.610069496503, 7861.2531809478005, 8003.31971782405, 8158.796030099295, 8232.670693172206, 7493.625318734042, 7542.6605802739, 7543.47195696307, 7785.766427007199, 7802.219778022152, 4782.163121453801, 4845.964694828181, 4887.462379138292, 4968.944099378856, 5012.47369026247, 2014.486305991992, 2016.4353980885376, 2043.7751847296786, 2064.9793502064786, 2106.8525203235627, 850.9319254459629, 891.6032365597376, 958.7842735384482, 961.6201600367956, 1007.9546420411099, 19192.616147676967, 20094.39716808498, 20094.89952550228, 20392.54707828571, 20519.0, 975.7316737897135, 979.6081567373108, 1012.3268026762267, 1014.9594016239415, 1043.5251960358019, 10663.360198388122, 11049.889501104886, 11052.336859788278, 11249.550017999352, 11300.886991129983, 444415.0, 456455.0, 457083.0, 472695.0, 473939.0, 89600.5519972396, 91461.0, 92061.53969230111, 92303.0, 92362.0, 995.5221493683073, 999.7750506136061, 1014.2241185493103, 1018.3431686562126, 1028.0850043461326, 16979.66040679204, 17150.672983527227, 17711.73432398541, 17748.3788067417, 17901.283948641907, 42090.789546052074, 42946.0, 43221.3516797242, 43602.0, 45765.0, 56783.0, 57874.0, 58022.4197758017, 58186.709066454394, 60034.0, 8225.300849427626, 8317.41778075529, 8338.666453341799, 8501.319894408309, 8517.361197910057, 10449.529771160163, 12275.263484190977, 12792.936035319764, 12883.227006379648, 13152.736945261233, 11164.274322169033, 11264.549418023187, 11365.374904380338, 11584.594539191088, 11954.940225298818, 10612.310199836986, 10899.673009809718, 10900.400477973788, 11122.944385278022, 11424.543018279175, 11055.22613417053, 11098.61154859576, 11484.712882178012, 11490.48292826808, 11915.702107447036, 8432.45189062709, 8434.873476897728, 8599.355048371272, 8606.311495080503, 8690.304775618062, 9026.774330641523, 10580.36517808934, 10941.617043403443, 10944.562217511211, 10957.83563246536], "value": 9349.574157383184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.5093090091216, 1491.5003473836264, 1505.4580351073614, 1561.3598424645897, 1640.9097499637514, 8492.405531612781, 8862.113788621135, 8927.375083744133, 9144.405613635108, 9162.541872906344, 8973.685920992766, 9069.0, 9071.319651026166, 9074.546272686355, 9074.909250907489, 2419.3104965084954, 2451.6199989001734, 2452.7424620414868, 2454.1901172613084, 2463.5688754467988, 2413.6578682168674, 2430.2344761400104, 2445.7921076708503, 2450.179189971353, 2451.816113791464, 2357.8682232528395, 2375.4298968247667, 2386.033656369173, 2389.4623709665275, 2410.108259943823, 2331.0, 2346.4485845826216, 2375.6674065630827, 2378.120095564635, 2387.5941090014653, 2337.544178885118, 2343.6601692754457, 2378.5361854438393, 2378.8691621960784, 2379.4408314046186, 8896.688615898478, 8985.191332780016, 9066.68266610672, 9123.543822808833, 9139.360244782867, 5111.284420181178, 5327.786888524454, 5329.733513324319, 5341.706206158659, 5351.1973204019705, 3410.7271418286477, 3428.5885693716664, 3509.31568344173, 3509.7016753575977, 3513.385157597436, 1150.4707834396188, 1159.1827761428174, 1163.5055101581793, 1181.1908842442954, 1185.419144619139, 12468.0, 12521.12352135351, 12586.37068146589, 12618.305993170372, 12651.051171162107, 4377.693561450732, 4503.977480112579, 4622.722636641813, 4633.907321853544, 4664.55686709762, 9902.257330700226, 9905.80188396228, 9910.35582687123, 9917.30578859473, 9924.454155021398, 5290.338707661543, 5337.226102215234, 5340.839774806762, 5364.865878353073, 5370.650907690988, 4381.233284175257, 4834.758262086882, 4974.90050198994, 4997.350344455198, 5016.147254966664, 3851.826667799956, 3927.4501569780255, 3996.18078293949, 4021.2560676274984, 4038.0522218780457, 1217.7990631545695, 1231.5258625429094, 1239.535174309634, 1240.6464157715009, 1258.087886282438, 977.2719324103589, 983.9065288797552, 996.5615129343066, 1003.5935446144323, 1007.7128018514688, 5984.790532331347, 6029.517638588903, 6115.419035191739, 6246.219222597176, 6330.778422755181, 946.9053094690613, 970.8786401699788, 980.7450062983532, 1007.4610083605236, 1038.1642777564134, 4142.2543942090115, 4263.16868210696, 4281.678874084456, 4336.501302350207, 4388.71473354231, 11208.327500350006, 11586.304821710724, 11610.94194529022, 11616.651500455, 11624.070074394029, 11436.599719009795, 11503.712407189887, 11508.19442639024, 11514.654560363202, 11522.942385288019, 8069.0, 8248.0, 8425.325973922194, 8441.240288374076, 8441.66233350659, 6025.126356678345, 6125.203723516092, 6319.24169099711, 6373.426391624776, 6584.473242140713, 10242.334248273839, 10384.844227336747, 10598.20513461509, 10624.415657138932, 10635.255532112678, 10263.794724105626, 10457.47712614351, 10633.0, 10759.13926885863, 10781.892181078088, 7257.201707812242, 7978.760637180894, 8143.348532117535, 8217.506949583045, 8531.402801803813, 8560.529170895661, 8887.111288871061, 8887.73336799897, 8891.155340242667, 8895.911040889509, 7562.546247225184, 7639.121501027231, 7642.312191902755, 8002.83994320122, 8070.192980701883, 7409.629518523944, 7463.925360746323, 7607.391408687403, 7643.197464266172, 7777.766666999999, 7103.2541583133025, 7233.204347521873, 7247.094113235846, 7284.125904891447, 7284.3808276294985, 5168.224766285088, 5349.732513374393, 5372.677639341496, 5443.564514838883, 5628.296462942132, 5403.162509810985, 5549.750261238173, 5556.555475562026, 5581.441855814386, 5686.459786320293], "value": 4757.957035076216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.13883500471246, 324.8083630657911, 331.4026099184768, 342.4452387132844, 343.90886415100005, 5054.368203974504, 5074.035933172695, 5173.835886925444, 5248.47515248475, 5261.710605916678, 5039.0, 5104.259882317062, 5128.974355128219, 5151.150060240066, 5158.92261616076, 4068.4507591475144, 4072.1855628874196, 4079.73481723687, 4082.7142100053006, 4088.589436644353, 3856.014152711356, 3994.3409337459284, 4086.4891888513935, 4087.652549533293, 4088.1823635272917, 4022.658074063708, 4032.4757781488365, 4046.109855831712, 4052.412400201969, 4060.741170237221, 4033.6773058155277, 4037.7577345359077, 4039.293123703355, 4047.7166598338276, 4054.4121102440276, 3643.981780091083, 3651.1602331463914, 3653.94519082214, 3662.285854258421, 3665.6151104133946, 4953.888272733622, 5076.23856421536, 5092.388913330387, 5093.541581257705, 5100.081985242655, 4705.12955103307, 4707.646926480494, 4719.457262414832, 4726.456457507396, 4727.3854398927915, 5264.815731449381, 5419.647722898038, 5424.864378390533, 5427.104527752916, 5432.375276843135, 3998.4402183694306, 4017.0961533654986, 4020.517537895442, 4026.0, 4046.291898917678, 5588.038339679976, 5599.544118529171, 5605.495505404533, 5622.971885140589, 5628.296462942132, 4139.089400331922, 4144.378343248537, 4146.647534959562, 4152.896177595524, 4159.272127377697, 3956.940645890314, 4161.9375709364385, 4172.436721042621, 4190.182914331737, 4197.992481804345, 4676.3453116563705, 4682.274247491576, 4684.625229981593, 4699.425692393087, 4699.718016918996, 5444.5916556258435, 5454.209139674805, 5460.334597947584, 5463.672179669233, 5468.91796623051, 1401.5865319730501, 1441.2001339256603, 1445.6747231872955, 1455.403284653287, 1462.3200211901517, 931.7933276406934, 937.9718608441758, 947.8436058050345, 956.2923436656824, 956.5934477846887, 4603.700759450625, 4649.7210167389385, 4658.86023419298, 4666.556677115668, 4711.199096153662, 4852.636052296092, 4882.414110306786, 4910.8772280693265, 4912.238603016538, 4934.8766280843265, 4495.797689103998, 4670.929936050962, 4684.742339171378, 4685.289869197786, 4706.247000479907, 2595.935101622437, 2627.908023219178, 2627.973720262773, 2628.7765539928937, 2635.499255141517, 5040.79836806531, 5074.238864170404, 5075.8223462179385, 5081.74591270435, 5095.4522738630685, 4761.500042495488, 4908.9754551227015, 5000.574951129122, 5011.724355160502, 5014.89970200594, 5019.447860735389, 5041.294218809443, 5054.873628159252, 5059.72171530562, 5061.911688986886, 4895.5558110356815, 4896.975515122402, 4912.214045752806, 4915.262710593297, 4917.26241063829, 4667.809708524304, 4847.248676455155, 4866.639679755387, 4876.683015603974, 4881.951180488291, 4981.903981124147, 4990.600751939909, 5015.648904576645, 5019.7490125494305, 5062.797488100582, 3722.9813850931655, 3750.887473375803, 3763.776772548987, 3888.475055867535, 3939.0, 5457.890842183214, 5457.918131228114, 5461.15352120422, 5466.398696143341, 5479.178123281539, 5339.4126646068125, 5353.304070470814, 5370.301860758233, 5382.542483888913, 5383.569314454756, 5185.0, 5328.893422131613, 5364.275822764033, 5369.946300537101, 5373.11343628297, 5361.276227709365, 5365.678059316453, 5366.692322301448, 5368.892622147613, 5377.24718539397, 5417.214503896992, 5418.241446197614, 5420.7289635518855, 5425.0, 5433.320834895638, 5071.123684236856, 5257.2902658140665, 5283.365996080495, 5302.28419163408, 5308.522232999048], "value": 4021.3286231063603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3216640690565, 743.1936349061268, 763.8166839958411, 789.9881501777471, 796.6773456750018, 14046.297685115742, 16531.421400250994, 17581.384651537184, 17581.472555823315, 18301.54246143844, 15679.60800979976, 15740.212989350515, 15751.527454176365, 15763.054216746974, 15766.448174313902, 792.2671528835832, 813.9715109971153, 817.2603793566832, 818.378032695153, 818.8034871630796, 654.6301339743054, 770.3182683325241, 786.9291763741262, 795.916428774979, 799.2966189753038, 853.5390888920007, 854.2909385210261, 854.9187827156442, 855.5209082913557, 856.1737922904396, 675.8242856857204, 853.2875049333813, 853.2960307746134, 853.5305581929945, 853.8889944307232, 591.2254946020727, 604.0003793721398, 607.171211296577, 609.5337067143639, 610.1610285856947, 13990.370433330525, 14024.158550487004, 14394.640133996629, 14426.927865360605, 14455.060421072596, 14523.636909077251, 14678.412863485448, 14990.700185996327, 15159.545213643498, 15276.159811210378, 13075.86924130756, 13399.665008374772, 13518.0, 13831.861681383158, 13834.446622135103, 4614.723116613014, 4648.140094082605, 4670.252759558454, 4870.366852309213, 4878.902421951577, 80933.0, 81110.59444702798, 82321.58839205766, 87666.0, 90435.0, 11619.477123529461, 11752.294862308288, 11811.0, 12101.75796484083, 12485.563005294953, 22129.889350553465, 22135.667964980537, 22141.335759927228, 22202.555948881254, 22304.442388940082, 8689.86017288263, 8700.30397568193, 8762.605682744292, 8762.693305734269, 9124.361294709306, 4725.10223057618, 4746.691465054761, 4778.402699662543, 4835.734034628129, 4891.192953162688, 3437.432823584131, 3532.4701294805986, 3547.4856145858707, 3550.396432606463, 3550.786952782841, 579.4607850408207, 583.813179782474, 583.8410754652012, 588.8410129265075, 605.8545948972215, 654.8493846415352, 655.2530115668142, 712.989305160423, 719.1478098453349, 728.2717282717283, 9535.761605959906, 9743.512824358753, 9902.455364954996, 10039.69880903574, 10299.639512617023, 559.9445046088072, 573.8766563714274, 666.0808084842982, 708.5512409570388, 753.6004527559971, 4726.763661816895, 5344.3853956795465, 5513.09034009392, 5528.889422211533, 5540.861478463071, 106978.0, 113691.0, 119073.0, 121105.0, 121883.0, 101318.49340753249, 102230.0, 103336.48331758293, 109105.0, 111152.0, 92959.0, 93444.53277733568, 95225.0, 95927.52036239774, 96963.0, 10046.54790534413, 10314.845277320695, 10329.586816527555, 10349.778190651765, 10464.0, 50721.492785073155, 50820.49179508157, 51343.74328128336, 51563.48436515737, 53848.0, 75482.62258688672, 77521.61239193768, 79227.0, 81713.59143204246, 82178.58910705408, 12620.242785432903, 13246.072774905664, 13254.403551839998, 13315.733685326046, 13632.863671363557, 15215.77176342378, 15377.461788837338, 15649.974759717363, 15896.205189740698, 16801.495955121365, 13631.318434078456, 14316.785248221493, 14337.354819033377, 14624.561263162122, 14950.476733314283, 13773.38019789132, 13788.0, 13817.79273310881, 13855.237961912191, 14767.556973290819, 14442.566722998326, 14445.910944834191, 14657.853421465648, 14814.555563333117, 14950.626234344229, 11187.552497899993, 11371.67613975101, 11655.417229138679, 11774.470148843151, 12168.452419641315, 11751.88248117542, 11847.35067939584, 11896.881031189578, 11897.940510297392, 12060.879391206327], "value": 7820.441775474145, "unit": "score"}], "name": "dromaeo_css", "value": 7297.570044610558, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 131.0, 111.0, 119.0, 111.0, 113.0, 112.0, 111.0, 111.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 143.0, 182.0, 121.0, 144.0, 150.0, 121.0, 170.0, 120.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 158.0, 162.0, 161.0, 162.0, 162.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 173.0, 77.0, 75.0, 75.0, 78.0, 169.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 160.0, 82.0, 81.0, 81.0, 146.0, 81.0, 82.0, 140.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 53.0, 54.0, 54.0, 54.0, 53.0, 55.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 63.0, 61.0, 63.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 81.0, 82.0, 84.0, 78.0, 86.0, 84.0, 78.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 137.0, 130.0, 123.0, 130.0, 131.0, 124.0, 166.0, 125.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 161.0, 163.0, 164.0, 161.0, 161.0, 165.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 65.0, 64.0, 66.0, 65.0, 63.0, 68.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1531.0000000000002, "alertThreshold": 2.0}]} 23:36:59 INFO - Return code: 0 23:36:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:36:59 INFO - # TBPL SUCCESS # 23:36:59 INFO - Running post-action listener: _resource_record_post_action 23:36:59 INFO - [mozharness: 2016-08-30 06:36:59.377924Z] Finished run-tests step (success) 23:36:59 INFO - Running post-run listener: _resource_record_post_run 23:36:59 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 423497728; Read time: 0; Write time: 240704 23:36:59 INFO - TinderboxPrint: CPU usage
13.1% 23:36:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:36:59 INFO - TinderboxPrint: I/O write bytes / time
423,497,728 / 240,704 23:36:59 INFO - TinderboxPrint: CPU idle
8,288.0 (86.9%) 23:36:59 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 23:36:59 INFO - TinderboxPrint: Swap in / out
0 / 0 23:36:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 135041024; Read time: 0; Write time: 84028 23:36:59 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288112640; Read time: 0; Write time: 156676 23:36:59 INFO - Running post-run listener: _upload_blobber_files 23:36:59 INFO - Blob upload gear active. 23:36:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:36:59 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 23:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:37:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:37:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:37:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:37:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:02 INFO - (blobuploader) - INFO - Done attempting. 23:37:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:37:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:37:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:03 INFO - (blobuploader) - INFO - Done attempting. 23:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:08 INFO - (blobuploader) - INFO - Done attempting. 23:37:08 INFO - (blobuploader) - INFO - Iteration through files over. 23:37:08 INFO - Return code: 0 23:37:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:37:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:37:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37f40c407a0d50faa88dada13e36f23fdf1c62ed35f7eec0c4ff1aef9ff9e3a9ff7192c0fbd4fa1c5f57e26934a4d4f072249336b526d101c37dec469b07ac00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d120196890cb819f864731e2d04eb78b9dac8f1ef5d4a4c6bb91ab1445b9b9e7491d052aa47ff3b99b461b7a84766ea0c6f167c7623dd18d523d1d6b6354d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e5629154813dbdd3a2acc3c6fec72b5cfacf291e5491b1153577e50ff86d94db113b47fb497bea0cce1849fd2176b32c3585c999c80d0abfb16a9c2e027090"} 23:37:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:37:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:37:08 INFO - Contents: 23:37:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37f40c407a0d50faa88dada13e36f23fdf1c62ed35f7eec0c4ff1aef9ff9e3a9ff7192c0fbd4fa1c5f57e26934a4d4f072249336b526d101c37dec469b07ac00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d120196890cb819f864731e2d04eb78b9dac8f1ef5d4a4c6bb91ab1445b9b9e7491d052aa47ff3b99b461b7a84766ea0c6f167c7623dd18d523d1d6b6354d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e5629154813dbdd3a2acc3c6fec72b5cfacf291e5491b1153577e50ff86d94db113b47fb497bea0cce1849fd2176b32c3585c999c80d0abfb16a9c2e027090"} 23:37:08 INFO - Running post-run listener: copy_logs_to_upload_dir 23:37:08 INFO - Copying logs to upload dir... 23:37:08 INFO - mkdir: /builds/slave/test/build/upload/logs 23:37:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.902233 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-29 23:37:08.147852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 23:37:08.151485) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37f40c407a0d50faa88dada13e36f23fdf1c62ed35f7eec0c4ff1aef9ff9e3a9ff7192c0fbd4fa1c5f57e26934a4d4f072249336b526d101c37dec469b07ac00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d120196890cb819f864731e2d04eb78b9dac8f1ef5d4a4c6bb91ab1445b9b9e7491d052aa47ff3b99b461b7a84766ea0c6f167c7623dd18d523d1d6b6354d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e5629154813dbdd3a2acc3c6fec72b5cfacf291e5491b1153577e50ff86d94db113b47fb497bea0cce1849fd2176b32c3585c999c80d0abfb16a9c2e027090"} build_url:https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/Jfv-ai69SBGbQaIcJQNyTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37f40c407a0d50faa88dada13e36f23fdf1c62ed35f7eec0c4ff1aef9ff9e3a9ff7192c0fbd4fa1c5f57e26934a4d4f072249336b526d101c37dec469b07ac00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d120196890cb819f864731e2d04eb78b9dac8f1ef5d4a4c6bb91ab1445b9b9e7491d052aa47ff3b99b461b7a84766ea0c6f167c7623dd18d523d1d6b6354d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e5629154813dbdd3a2acc3c6fec72b5cfacf291e5491b1153577e50ff86d94db113b47fb497bea0cce1849fd2176b32c3585c999c80d0abfb16a9c2e027090"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 23:37:08.176294) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:37:08.176654) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472537136.831680-1922166696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 23:37:08.261106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 23:37:08.261417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 23:37:08.261730) ========= ========= Total master_lag: 0.17 =========