builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1471302730.44 results: success (0) buildid: 20160815144333 builduid: 28afb5a3c2634df6bde9d75e4932fae5 revision: 794db78767b9f9ec7714c74cd3ae38b561196b6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.443410) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.443871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.444165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.460944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.461245) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 16:12:10-- 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% 225M=0s 2016-08-15 16:12:10 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.598126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.598447) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.647899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:10.648254) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 794db78767b9f9ec7714c74cd3ae38b561196b6d --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 794db78767b9f9ec7714c74cd3ae38b561196b6d --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=5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 16:12:10,855 truncating revision to first 12 chars 2016-08-15 16:12:10,855 Setting DEBUG logging. 2016-08-15 16:12:10,855 attempt 1/10 2016-08-15 16:12:10,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/794db78767b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 16:12:11,177 unpacking tar archive at: fx-team-794db78767b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686931 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:11.349409) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:11.349736) ========= script_repo_revision: 794db78767b9f9ec7714c74cd3ae38b561196b6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:11.350130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:11.350466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 16:12:11.361135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-15 16:12:11.361598) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:12:11 INFO - MultiFileLogger online at 20160815 16:12:11 in /builds/slave/test 16:12:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:12:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:11 INFO - {'append_to_log': False, 16:12:11 INFO - 'base_work_dir': '/builds/slave/test', 16:12:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:12:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:11 INFO - 'branch': 'Fx-Team-Non-PGO', 16:12:11 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:11 INFO - 'config_files': ('talos/linux_config.py',), 16:12:11 INFO - 'default_actions': ('clobber', 16:12:11 INFO - 'read-buildbot-config', 16:12:11 INFO - 'download-and-extract', 16:12:11 INFO - 'populate-webroot', 16:12:11 INFO - 'create-virtualenv', 16:12:11 INFO - 'install', 16:12:11 INFO - 'run-tests'), 16:12:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:11 INFO - 'download_minidump_stackwalk': True, 16:12:11 INFO - 'download_symbols': 'ondemand', 16:12:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:11 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:11 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:11 INFO - 'installer_path': 'installer.exe', 16:12:11 INFO - 'log_level': 'info', 16:12:11 INFO - 'log_name': 'talos', 16:12:11 INFO - 'log_to_console': True, 16:12:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:12:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:12:11 INFO - 'opt_config_files': (), 16:12:11 INFO - 'pip_index': False, 16:12:11 INFO - 'sps_profile': False, 16:12:11 INFO - 'sps_profile_interval': 0, 16:12:11 INFO - 'suite': 'dromaeojs', 16:12:11 INFO - 'system_bits': '32', 16:12:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:11 INFO - 'title': 'talos-linux64-ix-011', 16:12:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:11 INFO - 'use_talos_json': True, 16:12:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:11 INFO - 'work_dir': 'build'} 16:12:11 INFO - [mozharness: 2016-08-15 23:12:11.662745Z] Running clobber step. 16:12:11 INFO - Running pre-action listener: _resource_record_pre_action 16:12:11 INFO - Running main action method: clobber 16:12:11 INFO - rmtree: /builds/slave/test/build 16:12:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:12 INFO - Running post-action listener: _resource_record_post_action 16:12:12 INFO - [mozharness: 2016-08-15 23:12:12.636431Z] Finished clobber step (success) 16:12:12 INFO - [mozharness: 2016-08-15 23:12:12.636529Z] Running read-buildbot-config step. 16:12:12 INFO - Running pre-action listener: _resource_record_pre_action 16:12:12 INFO - Running main action method: read_buildbot_config 16:12:12 INFO - Using buildbot properties: 16:12:12 INFO - { 16:12:12 INFO - "project": "", 16:12:12 INFO - "product": "firefox", 16:12:12 INFO - "script_repo_revision": "production", 16:12:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:12:12 INFO - "repository": "", 16:12:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:12:12 INFO - "buildid": "20160815144333", 16:12:12 INFO - "pgo_build": "False", 16:12:12 INFO - "basedir": "/builds/slave/test", 16:12:12 INFO - "buildnumber": 1868, 16:12:12 INFO - "slavename": "talos-linux64-ix-011", 16:12:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:12:12 INFO - "platform": "ubuntu64_hw", 16:12:12 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 16:12:12 INFO - "branch": "fx-team", 16:12:12 INFO - "repo_path": "integration/fx-team", 16:12:12 INFO - "revision": "794db78767b9f9ec7714c74cd3ae38b561196b6d", 16:12:12 INFO - "stage_platform": "linux64", 16:12:12 INFO - "builduid": "28afb5a3c2634df6bde9d75e4932fae5", 16:12:12 INFO - "slavebuilddir": "test" 16:12:12 INFO - } 16:12:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:12:12 INFO - Running post-action listener: _resource_record_post_action 16:12:12 INFO - [mozharness: 2016-08-15 23:12:12.638948Z] Finished read-buildbot-config step (success) 16:12:12 INFO - [mozharness: 2016-08-15 23:12:12.639035Z] Running download-and-extract step. 16:12:12 INFO - Running pre-action listener: _resource_record_pre_action 16:12:12 INFO - Running main action method: download_and_extract 16:12:12 INFO - mkdir: /builds/slave/test/build/tests 16:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:12 INFO - trying https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:12:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:12:13 INFO - Downloaded 1361 bytes. 16:12:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:12:13 INFO - Using the following test package requirements: 16:12:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:12:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:12:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'jsshell-linux-x86_64.zip'], 16:12:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:12:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:12:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:12:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:12:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:12:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:13 INFO - trying https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:12:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:14 INFO - Downloaded 20264950 bytes. 16:12:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:12:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:18 INFO - trying https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:12:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:19 INFO - Downloaded 20264950 bytes. 16:12:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:23 INFO - trying https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:12:25 INFO - Downloaded 14413719 bytes. 16:12:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:25 INFO - trying https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:12:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:12:27 INFO - Downloaded 55615309 bytes. 16:12:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:12:27 INFO - mkdir: /builds/slave/test/properties 16:12:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:27 INFO - Contents: 16:12:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:12:28 INFO - Running post-action listener: _resource_record_post_action 16:12:28 INFO - Running post-action listener: set_extra_try_arguments 16:12:28 INFO - [mozharness: 2016-08-15 23:12:28.382249Z] Finished download-and-extract step (success) 16:12:28 INFO - [mozharness: 2016-08-15 23:12:28.382473Z] Running populate-webroot step. 16:12:28 INFO - Running pre-action listener: _resource_record_pre_action 16:12:28 INFO - Running main action method: populate_webroot 16:12:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:28 INFO - '--tppagecycles', 16:12:28 INFO - '7'], 16:12:28 INFO - 'tests': ['tsvgm']}}, 16:12:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['damp', 'tps']}, 16:12:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'tests': ['damp', 'tps']}, 16:12:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['dromaeo_dom']}, 16:12:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['basic_compositor_video']}, 16:12:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:12:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['a11yr', 16:12:28 INFO - 'ts_paint', 16:12:28 INFO - 'tpaint', 16:12:28 INFO - 'sessionrestore', 16:12:28 INFO - 'sessionrestore_no_auto_restore', 16:12:28 INFO - 'tabpaint']}, 16:12:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:28 INFO - 'ts_paint', 16:12:28 INFO - 'tpaint', 16:12:28 INFO - 'sessionrestore', 16:12:28 INFO - 'sessionrestore_no_auto_restore', 16:12:28 INFO - 'tabpaint']}, 16:12:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:12:28 INFO - 'ts_paint', 16:12:28 INFO - 'tpaint', 16:12:28 INFO - 'sessionrestore', 16:12:28 INFO - 'sessionrestore_no_auto_restore', 16:12:28 INFO - 'tabpaint']}, 16:12:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:12:28 INFO - 'ts_paint', 16:12:28 INFO - 'tpaint', 16:12:28 INFO - 'sessionrestore', 16:12:28 INFO - 'sessionrestore_no_auto_restore', 16:12:28 INFO - 'tabpaint']}, 16:12:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['a11yr', 16:12:28 INFO - 'ts_paint', 16:12:28 INFO - 'tpaint', 16:12:28 INFO - 'sessionrestore', 16:12:28 INFO - 'sessionrestore_no_auto_restore', 16:12:28 INFO - 'tabpaint']}, 16:12:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['a11yr', 16:12:28 INFO - 'ts_paint', 16:12:28 INFO - 'tpaint', 16:12:28 INFO - 'sessionrestore', 16:12:28 INFO - 'sessionrestore_no_auto_restore', 16:12:28 INFO - 'tabpaint']}, 16:12:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['tsvgx', 16:12:28 INFO - 'tsvgr_opacity', 16:12:28 INFO - 'tart', 16:12:28 INFO - 'tscrollx', 16:12:28 INFO - 'cart']}, 16:12:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:28 INFO - 'tsvgr_opacity', 16:12:28 INFO - 'tart', 16:12:28 INFO - 'tscrollx', 16:12:28 INFO - 'cart']}, 16:12:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'talos_options': ['--disable-e10s'], 16:12:28 INFO - 'tests': ['tp5o']}, 16:12:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'tests': ['tp5o']}, 16:12:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'talos_options': ['--disable-e10s', 16:12:28 INFO - '--xperf_path', 16:12:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:28 INFO - 'tests': ['tp5n']}, 16:12:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:28 INFO - 'talos_options': ['--xperf_path', 16:12:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:28 INFO - 'tests': ['tp5n']}}, 16:12:28 INFO - 'talos.zip': {'path': '', 16:12:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:28 INFO - Running post-action listener: _resource_record_post_action 16:12:28 INFO - [mozharness: 2016-08-15 23:12:28.400010Z] Finished populate-webroot step (success) 16:12:28 INFO - [mozharness: 2016-08-15 23:12:28.400097Z] Running create-virtualenv step. 16:12:28 INFO - Running pre-action listener: _resource_record_pre_action 16:12:28 INFO - Running main action method: create_virtualenv 16:12:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:12:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:28 INFO - Using real prefix '/usr' 16:12:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:29 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:30 INFO - Installing pip.................done. 16:12:30 INFO - Return code: 0 16:12:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:30 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:12:30 INFO - Using env: {'DISPLAY': ':0', 16:12:30 INFO - 'HOME': '/home/cltbld', 16:12:30 INFO - 'LANG': 'en_US.UTF-8', 16:12:30 INFO - 'LANGUAGE': 'en_US:en', 16:12:30 INFO - 'LOGNAME': 'cltbld', 16:12:30 INFO - 'MAIL': '/var/mail/cltbld', 16:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:30 INFO - 'MOZ_NO_REMOTE': '1', 16:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:30 INFO - 'NO_EM_RESTART': '1', 16:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:30 INFO - 'PWD': '/builds/slave/test', 16:12:30 INFO - 'SHELL': '/bin/bash', 16:12:30 INFO - 'SHLVL': '1', 16:12:30 INFO - 'TERM': 'linux', 16:12:30 INFO - 'TMOUT': '86400', 16:12:30 INFO - 'USER': 'cltbld', 16:12:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:30 INFO - '_': '/tools/buildbot/bin/python'} 16:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:12:31 INFO - Cleaning up... 16:12:31 INFO - Return code: 0 16:12:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:31 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:12:31 INFO - Using env: {'DISPLAY': ':0', 16:12:31 INFO - 'HOME': '/home/cltbld', 16:12:31 INFO - 'LANG': 'en_US.UTF-8', 16:12:31 INFO - 'LANGUAGE': 'en_US:en', 16:12:31 INFO - 'LOGNAME': 'cltbld', 16:12:31 INFO - 'MAIL': '/var/mail/cltbld', 16:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:31 INFO - 'MOZ_NO_REMOTE': '1', 16:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:31 INFO - 'NO_EM_RESTART': '1', 16:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:31 INFO - 'PWD': '/builds/slave/test', 16:12:31 INFO - 'SHELL': '/bin/bash', 16:12:31 INFO - 'SHLVL': '1', 16:12:31 INFO - 'TERM': 'linux', 16:12:31 INFO - 'TMOUT': '86400', 16:12:31 INFO - 'USER': 'cltbld', 16:12:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:31 INFO - '_': '/tools/buildbot/bin/python'} 16:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:31 INFO - Downloading/unpacking psutil>=3.1.1 16:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:33 INFO - Installing collected packages: psutil 16:12:33 INFO - Running setup.py install for psutil 16:12:33 INFO - building 'psutil._psutil_linux' extension 16:12:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:12:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:12:34 INFO - building 'psutil._psutil_posix' extension 16:12:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:12:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:12:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:34 INFO - Successfully installed psutil 16:12:34 INFO - Cleaning up... 16:12:34 INFO - Return code: 0 16:12:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:34 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:12:34 INFO - Using env: {'DISPLAY': ':0', 16:12:34 INFO - 'HOME': '/home/cltbld', 16:12:34 INFO - 'LANG': 'en_US.UTF-8', 16:12:34 INFO - 'LANGUAGE': 'en_US:en', 16:12:34 INFO - 'LOGNAME': 'cltbld', 16:12:34 INFO - 'MAIL': '/var/mail/cltbld', 16:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:34 INFO - 'MOZ_NO_REMOTE': '1', 16:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:34 INFO - 'NO_EM_RESTART': '1', 16:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:34 INFO - 'PWD': '/builds/slave/test', 16:12:34 INFO - 'SHELL': '/bin/bash', 16:12:34 INFO - 'SHLVL': '1', 16:12:34 INFO - 'TERM': 'linux', 16:12:34 INFO - 'TMOUT': '86400', 16:12:34 INFO - 'USER': 'cltbld', 16:12:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:34 INFO - '_': '/tools/buildbot/bin/python'} 16:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:12:36 INFO - Installing collected packages: mozsystemmonitor 16:12:36 INFO - Running setup.py install for mozsystemmonitor 16:12:36 INFO - Successfully installed mozsystemmonitor 16:12:36 INFO - Cleaning up... 16:12:36 INFO - Return code: 0 16:12:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:36 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:12:36 INFO - Using env: {'DISPLAY': ':0', 16:12:36 INFO - 'HOME': '/home/cltbld', 16:12:36 INFO - 'LANG': 'en_US.UTF-8', 16:12:36 INFO - 'LANGUAGE': 'en_US:en', 16:12:36 INFO - 'LOGNAME': 'cltbld', 16:12:36 INFO - 'MAIL': '/var/mail/cltbld', 16:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:36 INFO - 'MOZ_NO_REMOTE': '1', 16:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:36 INFO - 'NO_EM_RESTART': '1', 16:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:36 INFO - 'PWD': '/builds/slave/test', 16:12:36 INFO - 'SHELL': '/bin/bash', 16:12:36 INFO - 'SHLVL': '1', 16:12:36 INFO - 'TERM': 'linux', 16:12:36 INFO - 'TMOUT': '86400', 16:12:36 INFO - 'USER': 'cltbld', 16:12:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:36 INFO - '_': '/tools/buildbot/bin/python'} 16:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:39 INFO - warning: no files found matching '*.txt' 16:12:39 INFO - no previously-included directories found matching 'build' 16:12:39 INFO - no previously-included directories found matching 'dist' 16:12:39 INFO - no previously-included directories found matching '.git*' 16:12:39 INFO - Installing collected packages: jsonschema, functools32 16:12:39 INFO - Running setup.py install for functools32 16:12:39 INFO - warning: no files found matching '*.txt' 16:12:39 INFO - no previously-included directories found matching 'build' 16:12:39 INFO - no previously-included directories found matching 'dist' 16:12:39 INFO - no previously-included directories found matching '.git*' 16:12:39 INFO - Successfully installed jsonschema functools32 16:12:39 INFO - Cleaning up... 16:12:39 INFO - Return code: 0 16:12:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:39 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:12:39 INFO - Using env: {'DISPLAY': ':0', 16:12:39 INFO - 'HOME': '/home/cltbld', 16:12:39 INFO - 'LANG': 'en_US.UTF-8', 16:12:39 INFO - 'LANGUAGE': 'en_US:en', 16:12:39 INFO - 'LOGNAME': 'cltbld', 16:12:39 INFO - 'MAIL': '/var/mail/cltbld', 16:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:39 INFO - 'MOZ_NO_REMOTE': '1', 16:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:39 INFO - 'NO_EM_RESTART': '1', 16:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:39 INFO - 'PWD': '/builds/slave/test', 16:12:39 INFO - 'SHELL': '/bin/bash', 16:12:39 INFO - 'SHLVL': '1', 16:12:39 INFO - 'TERM': 'linux', 16:12:39 INFO - 'TMOUT': '86400', 16:12:39 INFO - 'USER': 'cltbld', 16:12:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:39 INFO - '_': '/tools/buildbot/bin/python'} 16:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:12:39 INFO - Cleaning up... 16:12:39 INFO - Return code: 0 16:12:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:39 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:12:39 INFO - Using env: {'DISPLAY': ':0', 16:12:39 INFO - 'HOME': '/home/cltbld', 16:12:39 INFO - 'LANG': 'en_US.UTF-8', 16:12:39 INFO - 'LANGUAGE': 'en_US:en', 16:12:39 INFO - 'LOGNAME': 'cltbld', 16:12:39 INFO - 'MAIL': '/var/mail/cltbld', 16:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:39 INFO - 'MOZ_NO_REMOTE': '1', 16:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:39 INFO - 'NO_EM_RESTART': '1', 16:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:39 INFO - 'PWD': '/builds/slave/test', 16:12:39 INFO - 'SHELL': '/bin/bash', 16:12:39 INFO - 'SHLVL': '1', 16:12:39 INFO - 'TERM': 'linux', 16:12:39 INFO - 'TMOUT': '86400', 16:12:39 INFO - 'USER': 'cltbld', 16:12:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:39 INFO - '_': '/tools/buildbot/bin/python'} 16:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:40 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:42 INFO - Downloading docopt-0.6.1.tar.gz 16:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:42 INFO - Running setup.py install for blobuploader 16:12:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:42 INFO - Running setup.py install for requests 16:12:43 INFO - Running setup.py install for docopt 16:12:43 INFO - Successfully installed blobuploader requests docopt 16:12:43 INFO - Cleaning up... 16:12:43 INFO - Return code: 0 16:12:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:43 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:43 INFO - Using env: {'DISPLAY': ':0', 16:12:43 INFO - 'HOME': '/home/cltbld', 16:12:43 INFO - 'LANG': 'en_US.UTF-8', 16:12:43 INFO - 'LANGUAGE': 'en_US:en', 16:12:43 INFO - 'LOGNAME': 'cltbld', 16:12:43 INFO - 'MAIL': '/var/mail/cltbld', 16:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:43 INFO - 'MOZ_NO_REMOTE': '1', 16:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:43 INFO - 'NO_EM_RESTART': '1', 16:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:43 INFO - 'PWD': '/builds/slave/test', 16:12:43 INFO - 'SHELL': '/bin/bash', 16:12:43 INFO - 'SHLVL': '1', 16:12:43 INFO - 'TERM': 'linux', 16:12:43 INFO - 'TMOUT': '86400', 16:12:43 INFO - 'USER': 'cltbld', 16:12:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:43 INFO - '_': '/tools/buildbot/bin/python'} 16:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:43 INFO - Running setup.py (path:/tmp/pip-1Ql39C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:43 INFO - Running setup.py (path:/tmp/pip-mj8gOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:43 INFO - Running setup.py (path:/tmp/pip-B5_3mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:43 INFO - Running setup.py (path:/tmp/pip-_ymiH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:43 INFO - Running setup.py (path:/tmp/pip-xTTr1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:43 INFO - Running setup.py (path:/tmp/pip-FehKQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:43 INFO - Running setup.py (path:/tmp/pip-AKv8b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:44 INFO - Running setup.py (path:/tmp/pip-d0mG9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:44 INFO - Running setup.py (path:/tmp/pip-BRtj0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:44 INFO - Running setup.py (path:/tmp/pip-Ak8gtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:44 INFO - Running setup.py (path:/tmp/pip-YIJs8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:44 INFO - Running setup.py (path:/tmp/pip-QuMqXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:44 INFO - Running setup.py (path:/tmp/pip-nmEDVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:44 INFO - Running setup.py (path:/tmp/pip-jSsJdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:44 INFO - Running setup.py (path:/tmp/pip-TJ5TAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:44 INFO - Running setup.py (path:/tmp/pip-rQlE45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:44 INFO - Running setup.py (path:/tmp/pip-a8WCqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:44 INFO - Running setup.py install for manifestparser 16:12:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:44 INFO - Running setup.py install for mozcrash 16:12:44 INFO - Running setup.py install for mozdebug 16:12:44 INFO - Running setup.py install for mozdevice 16:12:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Running setup.py install for mozfile 16:12:45 INFO - Running setup.py install for mozhttpd 16:12:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Running setup.py install for mozinfo 16:12:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Running setup.py install for mozInstall 16:12:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Running setup.py install for mozleak 16:12:45 INFO - Running setup.py install for mozlog 16:12:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Running setup.py install for moznetwork 16:12:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Running setup.py install for mozprocess 16:12:45 INFO - Running setup.py install for mozprofile 16:12:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:45 INFO - Running setup.py install for mozrunner 16:12:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:46 INFO - Running setup.py install for mozscreenshot 16:12:46 INFO - Running setup.py install for moztest 16:12:46 INFO - Running setup.py install for mozversion 16:12:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:46 INFO - Cleaning up... 16:12:46 INFO - Return code: 0 16:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:46 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:46 INFO - Using env: {'DISPLAY': ':0', 16:12:46 INFO - 'HOME': '/home/cltbld', 16:12:46 INFO - 'LANG': 'en_US.UTF-8', 16:12:46 INFO - 'LANGUAGE': 'en_US:en', 16:12:46 INFO - 'LOGNAME': 'cltbld', 16:12:46 INFO - 'MAIL': '/var/mail/cltbld', 16:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:46 INFO - 'MOZ_NO_REMOTE': '1', 16:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:46 INFO - 'NO_EM_RESTART': '1', 16:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:46 INFO - 'PWD': '/builds/slave/test', 16:12:46 INFO - 'SHELL': '/bin/bash', 16:12:46 INFO - 'SHLVL': '1', 16:12:46 INFO - 'TERM': 'linux', 16:12:46 INFO - 'TMOUT': '86400', 16:12:46 INFO - 'USER': 'cltbld', 16:12:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:46 INFO - '_': '/tools/buildbot/bin/python'} 16:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:46 INFO - Running setup.py (path:/tmp/pip-3xZxsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:46 INFO - Running setup.py (path:/tmp/pip-yoC5Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:46 INFO - Running setup.py (path:/tmp/pip-qCKPUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:46 INFO - Running setup.py (path:/tmp/pip-7Ts9fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:46 INFO - Running setup.py (path:/tmp/pip-gl9yo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:47 INFO - Running setup.py (path:/tmp/pip-zYV5gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:47 INFO - Running setup.py (path:/tmp/pip-vuQWpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:47 INFO - Running setup.py (path:/tmp/pip-hznVct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:47 INFO - Running setup.py (path:/tmp/pip-X1S6bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:47 INFO - Running setup.py (path:/tmp/pip-SWAAQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:47 INFO - Running setup.py (path:/tmp/pip-gbMw7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:47 INFO - Running setup.py (path:/tmp/pip-QDepKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:47 INFO - Running setup.py (path:/tmp/pip-W1LETs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:47 INFO - Running setup.py (path:/tmp/pip-v8oK3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:47 INFO - Running setup.py (path:/tmp/pip-P2jlDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:47 INFO - Running setup.py (path:/tmp/pip-7QeWtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:47 INFO - Running setup.py (path:/tmp/pip-nGZ_ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:49 INFO - Downloading blessings-1.6.tar.gz 16:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:49 INFO - Installing collected packages: blessings 16:12:49 INFO - Running setup.py install for blessings 16:12:49 INFO - Successfully installed blessings 16:12:49 INFO - Cleaning up... 16:12:50 INFO - Return code: 0 16:12:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:50 INFO - Reading from file tmpfile_stdout 16:12:50 INFO - Current package versions: 16:12:50 INFO - argparse == 1.2.1 16:12:50 INFO - blessings == 1.6 16:12:50 INFO - blobuploader == 1.2.4 16:12:50 INFO - docopt == 0.6.1 16:12:50 INFO - functools32 == 3.2.3-2 16:12:50 INFO - jsonschema == 2.5.1 16:12:50 INFO - manifestparser == 1.1 16:12:50 INFO - mozInstall == 1.12 16:12:50 INFO - mozcrash == 0.17 16:12:50 INFO - mozdebug == 0.1 16:12:50 INFO - mozdevice == 0.48 16:12:50 INFO - mozfile == 1.2 16:12:50 INFO - mozhttpd == 0.7 16:12:50 INFO - mozinfo == 0.9 16:12:50 INFO - mozleak == 0.1 16:12:50 INFO - mozlog == 3.3 16:12:50 INFO - moznetwork == 0.27 16:12:50 INFO - mozprocess == 0.23 16:12:50 INFO - mozprofile == 0.28 16:12:50 INFO - mozrunner == 6.12 16:12:50 INFO - mozscreenshot == 0.1 16:12:50 INFO - mozsystemmonitor == 0.3 16:12:50 INFO - moztest == 0.7 16:12:50 INFO - mozversion == 1.4 16:12:50 INFO - psutil == 3.1.1 16:12:50 INFO - requests == 1.2.3 16:12:50 INFO - wsgiref == 0.1.2 16:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:50 INFO - Using env: {'DISPLAY': ':0', 16:12:50 INFO - 'HOME': '/home/cltbld', 16:12:50 INFO - 'LANG': 'en_US.UTF-8', 16:12:50 INFO - 'LANGUAGE': 'en_US:en', 16:12:50 INFO - 'LOGNAME': 'cltbld', 16:12:50 INFO - 'MAIL': '/var/mail/cltbld', 16:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:50 INFO - 'MOZ_NO_REMOTE': '1', 16:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:50 INFO - 'NO_EM_RESTART': '1', 16:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:50 INFO - 'PWD': '/builds/slave/test', 16:12:50 INFO - 'SHELL': '/bin/bash', 16:12:50 INFO - 'SHLVL': '1', 16:12:50 INFO - 'TERM': 'linux', 16:12:50 INFO - 'TMOUT': '86400', 16:12:50 INFO - 'USER': 'cltbld', 16:12:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:50 INFO - '_': '/tools/buildbot/bin/python'} 16:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:50 INFO - Cleaning up... 16:12:50 INFO - Return code: 0 16:12:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:50 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 0x7fb0ecc29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1190230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:12:50 INFO - Using env: {'DISPLAY': ':0', 16:12:50 INFO - 'HOME': '/home/cltbld', 16:12:50 INFO - 'LANG': 'en_US.UTF-8', 16:12:50 INFO - 'LANGUAGE': 'en_US:en', 16:12:50 INFO - 'LOGNAME': 'cltbld', 16:12:50 INFO - 'MAIL': '/var/mail/cltbld', 16:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:50 INFO - 'MOZ_NO_REMOTE': '1', 16:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:50 INFO - 'NO_EM_RESTART': '1', 16:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:50 INFO - 'PWD': '/builds/slave/test', 16:12:50 INFO - 'SHELL': '/bin/bash', 16:12:50 INFO - 'SHLVL': '1', 16:12:50 INFO - 'TERM': 'linux', 16:12:50 INFO - 'TMOUT': '86400', 16:12:50 INFO - 'USER': 'cltbld', 16:12:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:50 INFO - '_': '/tools/buildbot/bin/python'} 16:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:12:50 INFO - Cleaning up... 16:12:50 INFO - Return code: 0 16:12:50 INFO - Running post-action listener: _resource_record_post_action 16:12:50 INFO - Running post-action listener: _start_resource_monitoring 16:12:50 INFO - Starting resource monitoring. 16:12:50 INFO - [mozharness: 2016-08-15 23:12:50.724597Z] Finished create-virtualenv step (success) 16:12:50 INFO - [mozharness: 2016-08-15 23:12:50.725063Z] Running install step. 16:12:50 INFO - Running pre-action listener: _resource_record_pre_action 16:12:50 INFO - Running main action method: install 16:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:50 INFO - Reading from file tmpfile_stdout 16:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:51 INFO - Reading from file tmpfile_stdout 16:12:51 INFO - Output received: 16:12:51 INFO - Usage: mozinstall [options] installer 16:12:51 INFO - Options: 16:12:51 INFO - -h, --help show this help message and exit 16:12:51 INFO - -d DEST, --destination=DEST 16:12:51 INFO - Directory to install application into. [default: 16:12:51 INFO - "/builds/slave/test"] 16:12:51 INFO - --app=APP Application being installed. [default: firefox] 16:12:51 INFO - mkdir: /builds/slave/test/build/application 16:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:13:07 INFO - Reading from file tmpfile_stdout 16:13:07 INFO - Output received: 16:13:07 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:07 INFO - Running post-action listener: _resource_record_post_action 16:13:07 INFO - [mozharness: 2016-08-15 23:13:07.056641Z] Finished install step (success) 16:13:07 INFO - [mozharness: 2016-08-15 23:13:07.056890Z] Running run-tests step. 16:13:07 INFO - Running pre-action listener: _resource_record_pre_action 16:13:07 INFO - Running main action method: run_tests 16:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:07 INFO - Python 2.7.3 16:13:07 INFO - Return code: 0 16:13:07 INFO - grabbing minidump binary from tooltool 16:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:07 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 0x118a090>, '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 0x118d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:13:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:13:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:13:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:07 INFO - Return code: 0 16:13:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:13:07 INFO - Using env: {'DISPLAY': ':0', 16:13:07 INFO - 'HOME': '/home/cltbld', 16:13:07 INFO - 'LANG': 'en_US.UTF-8', 16:13:07 INFO - 'LANGUAGE': 'en_US:en', 16:13:07 INFO - 'LOGNAME': 'cltbld', 16:13:07 INFO - 'MAIL': '/var/mail/cltbld', 16:13:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:07 INFO - 'MOZ_NO_REMOTE': '1', 16:13:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:07 INFO - 'NO_EM_RESTART': '1', 16:13:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:07 INFO - 'PWD': '/builds/slave/test', 16:13:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:07 INFO - 'SHELL': '/bin/bash', 16:13:07 INFO - 'SHLVL': '1', 16:13:07 INFO - 'TERM': 'linux', 16:13:07 INFO - 'TMOUT': '86400', 16:13:07 INFO - 'USER': 'cltbld', 16:13:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694', 16:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:07 INFO - '_': '/tools/buildbot/bin/python'} 16:13:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:13:07 INFO - mozversion application_buildid: 20160815144333 16:13:07 INFO - mozversion application_changeset: 794db78767b9f9ec7714c74cd3ae38b561196b6d 16:13:07 INFO - mozversion application_display_name: Nightly 16:13:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:07 INFO - mozversion application_name: Firefox 16:13:07 INFO - mozversion application_remotingname: firefox 16:13:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:13:07 INFO - mozversion application_vendor: Mozilla 16:13:07 INFO - mozversion application_version: 51.0a1 16:13:07 INFO - mozversion platform_buildid: 20160815144333 16:13:07 INFO - mozversion platform_changeset: 794db78767b9f9ec7714c74cd3ae38b561196b6d 16:13:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:13:07 INFO - mozversion platform_version: 51.0a1 16:13:07 INFO - using testdate: 1471302787 16:13:07 INFO - actual date: 1471302787 16:13:07 INFO - starting webserver on 'localhost:55662' 16:13:07 INFO - SUITE-START | Running 2 tests 16:13:07 INFO - TEST-START | dromaeo_css 16:13:07 INFO - operating with platform_type : linux_ 16:13:07 INFO - Initialising browser for dromaeo_css test... 16:13:07 INFO - TEST-INFO | started process 11811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVg_Hi4/profile http://localhost:55662/getInfo.html) 16:13:12 INFO - PROCESS | 11811 | __metrics Screen width/height:1600/1200 16:13:12 INFO - PROCESS | 11811 | colorDepth:24 16:13:12 INFO - PROCESS | 11811 | Browser inner width/height: 1024/697 16:13:12 INFO - PROCESS | 11811 | __metrics 16:13:12 INFO - PROCESS | 11811 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:13:12 INFO - PROCESS | 11811 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:13:13 INFO - PROCESS | 11811 | console.error: PushService: 16:13:13 INFO - PROCESS | 11811 | stateChangeProcessEnqueue: Error transitioning state 16:13:13 INFO - PROCESS | 11811 | UnknownError 16:13:14 INFO - TEST-INFO | 11811: exit 0 16:13:14 INFO - Browser initialized. 16:13:14 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:14 INFO - TEST-INFO | started process 11891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVg_Hi4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:26 INFO - PROCESS | 11891 | RSS: Main: 157392896 16:13:26 INFO - PROCESS | 11891 | 16:14:17 INFO - PROCESS | 11891 | 1471302857173 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:16:30 INFO - PROCESS | 11891 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55662/tests/dromaeo/cssquery-ext.html) 16:16:31 INFO - PROCESS | 11891 | RSS: Main: 245391360 16:16:31 INFO - PROCESS | 11891 | 16:19:34 INFO - PROCESS | 11891 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-ext.html (next: http://localhost:55662/tests/dromaeo/cssquery-jquery.html) 16:19:35 INFO - PROCESS | 11891 | RSS: Main: 236646400 16:19:35 INFO - PROCESS | 11891 | 16:22:37 INFO - PROCESS | 11891 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55662/tests/dromaeo/cssquery-mootools.html) 16:22:37 INFO - PROCESS | 11891 | RSS: Main: 189861888 16:22:37 INFO - PROCESS | 11891 | 16:25:40 INFO - PROCESS | 11891 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55662/tests/dromaeo/cssquery-prototype.html) 16:25:40 INFO - PROCESS | 11891 | RSS: Main: 188588032 16:25:40 INFO - PROCESS | 11891 | 16:28:43 INFO - PROCESS | 11891 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55662/tests/dromaeo/cssquery-yui.html) 16:28:44 INFO - PROCESS | 11891 | RSS: Main: 189661184 16:28:44 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-yui.html (next: http://localhost:55662/tests/dromaeo/cssquery-dojo.html) 16:31:47 INFO - PROCESS | 11891 | RSS: Main: 283418624 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | __start_tp_report 16:31:47 INFO - PROCESS | 11891 | _x_x_mozilla_page_load 16:31:47 INFO - PROCESS | 11891 | _x_x_mozilla_page_load_details 16:31:47 INFO - PROCESS | 11891 | |i|pagename|runs| 16:31:47 INFO - PROCESS | 11891 | |0;dojo.html;2635.367511797169;2668.4262883480046;2674.438367942732;2698.177055997921;2699.514087464257;4716.268978308368;4773.856784296468;4819.373481447411;4839.443464001641;4841.39482564679;4759.785809638566;4781.952180478194;4833.32333473314;4845.491223421534;4847.684900481467;4356.281213599752;4407.11857628474;4411.338299255105;4467.285234362503;4566.40636717228;4500.032493014001;4531.229690952546;4564.497905230422;4568.9491416974115;4577.153226653063;4253.914921701579;4319.244132276839;4460.085682435093;4492.101579684077;4565.223911934979;4357.694961352707;4365.388845561624;4396;4439.356293337481;4461.643068554507;4335.544767799367;4362.214801335758;4395.582419670126;4397.054633253866;4404.4494438195225;4807.351007613962;4815.542523460265;4847.442544107403;4856.417229932431;4865.854024379274;4972.353594032788;5081.034603425337;5135.204043373245;5151.201563757623;5168.198929165986;5250.7374631268285;5259.973700131513;5261.184516399964;5262.342207224097;5270.92093618596;4652.976735116303;4879.829205977774;4887.169181239198;4888.071266459361;4892.657513974059;5209.947900521022;5265.210218467184;5276.868078298074;5339.7063161526485;5363.088274993261;5036.370453693288;5056.898862022739;5099;5106.234064890222;5112.207607820794;5008.29883816266;5180.663256888291;5219.973900130475;5221.66059206158;5236.1098613235845;5007.574356179693;5071.898562028812;5080.949190508121;5118.206677964921;5165.612579056586;5111.591072714174;5118.564921981599;5118.718470484159;5119.897602047939;5155.355580552431;4214.831406743696;4326.242907491176;4333.544977777288;4333.6316413104605;4376.627986621109;3733.8506459741848;3754.511913451234;3789.052736815796;3822.0827001519992;3869.4389313549377;4485.506594274627;4511.3458548510935;4515.390422292949;4551.294549344857;4557.08858228349;5219.321488206509;5225.242339860699;5227.529522342931;5237.371515418175;5241.266222728821;4370.147821174841;4453.710508816916;4498.302763071729;4516.119356725473;4585.426821647294;4651;4678.883027924261;4684.367610372556;4686.74222917736;4732.621390288768;4936.185529387611;4965.801367945314;4978.925316120333;4980.800767969241;5022.698638081727;5009.749512524432;5108.131617624938;5178.326817513699;5182.792688292426;5257.842264732064;4908.680935739166;4943.728094954812;4944.233643785219;4947.727874966911;4980.477049909852;5103.617228707936;5109.259157422079;5111.05445492585;5112.054269960069;5114.514121158484;5039.118154323052;5128.897422051613;5196.896062078662;5200.869978250574;5277.762500687555;5087.3386459759995;5093.592512599057;5096.210087436453;5098.847034588968;5103.4386217516785;5091.66904151229;5097.974510127426;5098.1588037973315;5101.642884998015;5123.615728820428;4815.879603009813;4916.803327866988;4967.3045773591;4995.400551933792;5063.417706963599;5099.974500127476;5111.795528178831;5116.641835071509;5117.92323115161;5158.484151584811;4970.627202959865;5001.149804533311;5008.273800299009;5017.1721665924715;5017.4731653175895 16:31:47 INFO - PROCESS | 11891 | |1;ext.html;576.4005434348278;584.763170915779;588.0561698473949;588.0913987888712;588.3939542271462;28724.85637571812;38905.41641875374;39776.602233977654;39798.40302395466;43566.56433435665;39485;40037.59962400375;40038.199236015265;40054.39918401219;40097.198056038935;7660.004199454077;7786.571738554378;7791.8052048698955;7797.844043119134;7800.921990780076;7537.736179233728;7607.695692172307;7615.200403957588;7618.200088990659;7623.047119110111;7618.200088990659;7644.961775191116;7652.31129198372;7660.157382687928;7660.387169026492;7576.469647124703;7622.656980435893;7626.237376262329;7626.351760100398;7629.504082234693;7582.128055273603;7653.234676532302;7655.196204398514;7658.157602663702;7669.6932122715025;36928.81535592332;37350.626493734984;37429.62570374289;37443.251134977145;37463.812680936695;3163.43058249515;3191.2021994501374;3280.475123980176;3366.040678406642;3565.5899571549085;27112.728872711414;29299;29555.113346599635;29565.70434295651;29649.407011859857;3386.0857568456627;3405.8297085145646;3570.5715314162208;3607.2785442911522;3622.4566315052953;246206.9999999982;246761;247571;247590;248466;51421.742891286056;51816.22275665868;51822.48177518177;51919.48080519222;52112;55061.72469137629;55150.17274740882;55175.44824551703;55234.723826380614;55279;13301.201927884164;13479.326033698277;13485.865141348657;13488.662783430493;13489.055766096475;10226.693199203886;10235.7441063974;10301.124404425707;10318.1745460363;10332;14565.41738330455;16571.337146514245;16619.3352265908;16632.417865374653;16638.504224366443;4714.124619112717;5226.869328266824;5394.136938089887;5437.238786569884;5553.72231388437;756.3268690865134;855.8587833007484;858.3948316436897;863.6459051788736;913.9131782480654;26203.73796262051;27755;28257.858710706725;28263.072155117577;28450.857745711553;937.4515908193647;956.4596003258137;982.6069572171189;997.576030187182;1016.1312078173204;14181.85818141826;15054;15069.924650376677;15251.771223431657;15328.310226039855;373801;374535;375614;376627;377024;49047.75476122668;49240.75379623079;49306.50693493091;49335.50664493381;49405.50594494009;1072.3619446429361;1106.5186643809968;1130.8529891114104;1167.5738355500182;1179.2452830188686;24441.533507989578;28147.296317592223;28766.137015889555;29476.410471790874;29550.556741648463;41417.171656567305;41970.58029419667;42000.369994449495;42013.36979945364;42017;222192;222701;223599;224258;224622;24207.273781786575;25256.242312730647;25270.368240794127;26179.727534058242;26258.474830502902;40492.59507405006;40770;40814.79592602018;41909;41956.79021604872;34352;34444.48333274953;34583;34885.82557087198;34990;34404;34431.483527746605;34541.30917381689;34550.82724586361;34681.30637387188;32694.67305326916;33356.166095847795;33473;34628.13429664178;34995.47506787349;30130.54804177895;32592.185195370304;32681.673183267863;32761.508577371835;32822.34355312928;24888.875555622108;25261.242162735147;25367.238982830546;25534;25574.23277301684 16:31:47 INFO - PROCESS | 11891 | |2;jquery.html;350.49178690898174;365.9798711070892;377.46023186842814;377.54505820486315;392.7113571524929;12860.614181574556;16129.112898790561;16376;16513.66972660546;17635.20641571129;16373.91813040933;16727.83272167278;16908.408205712803;17361.47915562532;17516.64966700665;4916.237983112624;4953.801847926079;5060.367454068241;5098.184290513518;5098.872528186806;3778.905527361824;5052.595792336622;5136.64043516954;5684;5996.2804463464445;5995.6702381369005;6014.308354539218;6014.729337179838;6023.638581685091;6029.21620189377;5162.096633089213;5454.481824226692;5475.67145971239;5484.451554844523;6006;5298.178782288752;5303.867403314909;5310.389305229909;5310.60170487215;5316.415194328621;19022.80977190224;19907.90046049775;20231.393058208276;20670.483237919023;20782.5843483131;1901.0589758069705;1916.089857317777;1948.8733232339853;1958.3341663834365;2084.333013435701;9037.593308301142;9277;9705.369151005161;9767.365121267096;9840.3603765755;1672.2474886301213;1719.9828001719948;1722.2766438095905;1777.5022993561824;1816.9909150454296;63758;68377;68385.31614683839;69088.96366554455;69710;9796.118349348593;9992.900070999198;9994.250431217688;10218.437985910847;10423.270371074104;13633.727325453436;13634;13641.590752277447;13647.522336718168;13672.179669219879;6696.86606267872;6828.760993365208;6853.520253582301;7008.369246767816;7087.397571206505;6295.496360291166;6336.398042185985;6492.123563318892;6499.8700025999215;6507.804765857032;4244.490661120685;4294.871153865389;4314.9784251078545;4424.756638384855;4443.422355093881;1748.930042798274;1821.6629923464202;1830.880992735468;1850.3616252392903;1858.461046296586;784.8430313937235;815.6941147069849;876.4084243135858;883.6862913665556;947.5404428852002;16309.102999334913;16923.37687658415;17118.48644540666;17457.825421745874;17693.20380582877;855.683397143061;862.4006315610591;863.3093525179831;890.3589415620743;925.9212966897754;9129.543522823833;9768.120869121813;9790.21678265737;9795.265355098396;9838.262130340254;366840;369870;382012;383921;385148;66886.66556667186;67957.66021169961;71694.64152679204;73112.26887731161;74928;910.2899738204344;911.7857303533664;948.3456415073578;950.4392408478892;959.0170075672492;15864.286107124975;15903.433798170548;16013;16530.09084500316;16917.830821691627;26993.865030674722;31901.68098318987;34140.487892682126;38246;38881.6111838878;49201.2619810696;52681.473185267656;53330;53635.19547206873;54446.455535445726;7432.405407567489;7448.441366897396;7549.547027178387;7655.846883062419;7798.142204357403;10999.890001099886;11966.521339146684;12043.397830108635;12214.14500984958;12299.569515067287;9604.903950960681;9761.463119528495;10993.560257589606;11032.117430605693;11095;10670.30643008202;10757.677269681923;10834.729131771768;10899.400532970445;11002.174836887105;10440.63457778974;10786.622468213574;10971.23201375896;11154.944225278821;11530.135239856876;7414;7685.154632990255;7696.307332340116;7701.92298077012;7936.444448888522;9480.715578532656;10038.749031274276;10110.848337275094;10119.241056920613;10212.795744085226 16:31:47 INFO - PROCESS | 11891 | |3;mootools.html;1214.8359971403859;1325.7083441642835;1359.6532884114552;1367.8974076944226;1606.8473495017977;6614.8677026459445;7404.296591823775;7648.923510764891;7652.617369131542;7875.8424831503335;7726.61366931654;7791.610419479018;7795.298423141916;7798.883016754753;7813.257740514656;2174.7933946275116;2200.427888748921;2200.7909248621436;2204.2836078274627;2205.5588882223537;2127.7659457459745;2152.8600640958366;2181.3892110209167;2181.5418762059985;2187.4968757185857;2118.8199003084756;2140.454184183031;2150.258160934475;2152.6340522111277;2173.402314363547;2106.5681535285307;2114.217739436403;2114.5982263370065;2114.661654135331;2116.460302622837;2031.5936812637383;2107.4204593736845;2108.040841417167;2111.419359676086;2115.2173695732677;7728;7873.330766884822;7880.605969701492;7887.921120788834;7890.56601886896;4404.383386325917;4566.817327306904;4568.474625418086;4576.45082590088;4588.541145885385;2671.3989352395556;2770.8614569271454;2813.43731253748;2820.591014302935;2826.802123851331;865.9523726195057;882.668999125328;883.7834730491006;885.9202671759573;890.9420887642283;10778.946105269502;10900.1279897608;10943.726406839813;10961.945190274077;10965.287256328313;3808.6762625176616;3941.625545573166;4094.733842300241;4101.282275601758;4128.6284234419045;8390.958045209734;8415.368847336475;8417.873731894026;8429.789255268544;8449.915500845036;4562.634989200856;4572.702774319659;4575.3823233863;4579.6794224403975;4585.266357382803;3650.0874781304674;4011.8796436106963;4194.3498757692605;4287.185434767384;4312.978435107867;3352.1116904020455;3376.544166537535;3490.406630872707;3501.8949431516585;3524.4360902255517;1011.9190464762802;1021.0810270756378;1023.8003589300164;1032.1587905856702;1063.4151216830712;662.592505609047;787.6180052674448;802.8314054048599;825.4593241426875;835.1856939483954;4863.7324947128245;4878.317035615017;4917.827876024322;4966.726830024311;5095.108356037678;388.12671489149415;402.4607026584391;402.4807997683015;405.0885507607882;406.520306038877;3347.7991320520846;3503.7197024238;3568.3933731265747;3580.230250496104;3588.461730740358;9128.58921348541;9522.52387380642;9598.376105553116;9615.9038409615;9687.418754874589;9446;9473.573689184002;9487.430754154773;9509.714708558755;9539.3322467428;7296.306850849161;7340.302671246223;7347.412207023533;7351.705931762776;7352.007478990268;4831.227003679394;4839.491853355347;4916.213405855046;4969.627277954096;5047.192449208256;8902.59938302765;8902.688405905763;8931.598078086372;8994.370394072352;9045.819083618422;8490.702825401082;8636;8718.65125394977;9131;9178.449293042439;5683.744231509675;5995.490383317292;6688.264290927897;6786.830329241809;6821.727130914708;7313.305236002571;7538.962305188439;7544.132424771002;7547.490501899532;7550.622468876644;6597.538172327891;6716.798496045127;6741.696623652046;6777.322267773183;6881.65591720422;6651.73393064272;6677.29888361715;6782.762603308861;6806.6256355900905;6837.521373503807;5898.380670029585;5997.55018373615;5998.70006499682;6005.669688167192;6011.428914253139;4358.455193100863;4364.367166760865;4405.18504076734;4416.867493975186;4567;4376.256036473744;4444.888877778081;4525.886852828706;4616.630669546361;4619.7690115493415 16:31:47 INFO - PROCESS | 11891 | |4;prototype.html;301.92602812310986;302.3559817588538;308.53719420868697;310.88963417986616;311.07145171662586;4878.829240976566;4926.162552366098;4929.778159982796;4961.925571116427;4989.900201995958;4807.687500312477;4829.686070405422;4911.968486617806;4912.312276281324;4914.852554423364;3652.561692596892;3786.3563194257044;3791.3744232201793;3841.1165431950667;3861.61383861613;3843.9039024024482;3850.595687452819;3852.268069066882;3855.556610989744;3864.9613503865025;3800.6959443244473;3804;3812.1994381179984;3818.2745278397156;3824.7131465140087;3626.8005259710835;3665.688416484602;3795.3168429682646;3824.8852534424013;3852.8651497197743;3403.421418358885;3405.1997780521556;3409.590849098099;3412.2426950120707;3413.4367829308135;4820.783064762059;4823.3729615149805;4827.975860120677;4832.985073134646;4854.393200849894;4103.589641035873;4332.761698106603;4416.315471101984;4422.491413487458;4423.911521769546;5090.236464530313;5097.745112744385;5128.845884728423;5143;5152.201408781645;3630.945535816965;3634;3635.2366003139373;3635.5455568053994;3647.544056992876;5086.54221120101;5254.97372513135;5349.197620356938;5364.383095943977;5380.381256155553;3634.9276963295893;3683.778973261613;3690.2066055797595;3699.9445008324897;3710.387786015331;3759;3762.6425489578446;3765.9643598010766;3772.490713753663;3776.206996530759;4290.656747460196;4309.913801723948;4311.76285304305;4313.482382114166;4324.0919406924895;4875.780589873464;5084.491550844886;5085.415177254663;5132.743362831919;5143.717095559706;1282.160185078775;1303.947842086325;1305.8171855940177;1318.2156616813172;1319.195290872567;780.3094261578544;813.7029984055895;817.3665409307715;817.5871185051511;823.5799742131436;4455;4527.796249168795;4587.770611469413;4594.379758732595;4609.976950115228;5291.1798671206025;5299.920501192485;5304.223085266479;5305;5343.812966546152;4398.2962725964335;4557.863264102082;4560.977195114003;4566;4614.676972611885;2770.016644091359;2784.484870299001;2787.1081253998527;2789.800385834111;2806.1581525542256;4979.178435558092;4987.825426110068;5051.949480505222;5056.898862022813;5071.3153724247495;5105.285260063594;5310.203469479532;5419.620626556182;5430.13117901134;5431.53831924283;4956.306117143603;5003.424606170337;5006.774695138727;5011.473795251446;5023.6483446159145;5301.946980530145;5320.201969704575;5326.786928522815;5344;5347.51872331492;5027.446980832178;5129.717865517432;5170.457102004236;5185.896282074413;5186.196139598368;4969.776360063734;5056.797728090835;5061.974690126526;5063.316452278895;5072.416672082758;3716.6097559756918;3749.2501499699624;3766.1526156615637;3766.8681596144;3770.246835221635;5186.325777648882;5208.5312321891215;5278.788848446019;5343.171808369709;5355.062863998707;5064.898702026013;5087.64386492942;5180.119379705535;5192.299039629753;5203.141481655484;5146.202338637517;5177.404598471224;5185.9222111669105;5200.893638076585;5203.531682148625;4898.289747986593;5020.113434774946;5045.520675535819;5081.18701007837;5089.770960306869;4908.312836202863;4999.500049994971;5090.618203634668;5146.459621739664;5160.922586161136;5032.798688052437;5035.018171456531;5061.31672224245;5088.720120393414;5105.978804239093 16:31:47 INFO - PROCESS | 11891 | |5;yui.html;640.673256639114;665.8701553197128;668.5320275806936;671.6910221298205;728.2971932085536;11133;12794.23234605923;13479;13889.7916531252;13890.583282501528;13944.651383715413;14064.367103480343;14741.778873316909;14745;14758.409663613442;761.3072104384997;772.9613519324039;780.1379475679378;780.6135962698472;780.6292011294646;629.1789215074326;758.2531206761336;775.1860546426229;775.9689612415497;776.1927595300908;818.7543736878943;826.3554427546493;827.9710210142646;828.5443006346516;828.6271177969937;822.4448497264383;822.48183644304;822.8354329134197;822.8889099971547;823.0082750285922;597.8983572792636;598.5660396212754;598.7036416973626;598.9281286245679;598.9880202395972;12976.156549824325;13105.410256538478;13319.334033298393;13471.595852124452;13553;13316.400761965735;13578.1853088814;13760.93119534396;13835.169889806542;14080.577582672537;9999.500024998793;10137.847932280947;10250.538725757358;10358.274920755475;10452.425116618582;3304.603447586281;3315.1546355679147;3316.4196265653654;3335.8999230023137;3346.9832650836834;66123.33876661268;67249.32750672528;68787;70345.29654703439;71225.2877471229;10376.377417354983;10529.36823790575;10614.628488002883;10657.73355666099;10666.466676666136;19579.902100489406;19931.20275189005;19946.30187943415;19954.20183192685;19992.50018749543;6460.12788273577;6908.101946746991;6951.339622735832;6958.304169583002;7338.156112047183;3736.4768932349493;3800.3539398302355;3822.827972741233;3836.462895194675;4007.959920400817;2848.188266344082;2934.383779406306;3280.9343813123605;3440.449528075496;3469.774464659789;551.3136145498879;564.7656222667629;566.2355819643449;567.2993852592045;569.4191924237255;459.4188351735058;482.69831355402874;508.16914345046115;512.2853619201194;564.3594520219498;7484.812879677943;7844.37245020397;7906.446548741533;7981.600919953979;8122.309603683635;459.56341475598316;462.81718721104977;502.62052150626045;528.899509093271;561.7107189797258;3538.203904121552;3789.4694742736037;3958.267720471722;3976.324024915771;4157.812898419578;57436;98178.50910745401;100286;102510;103252;67981.6600917002;75739.62130189314;79562.60218698869;79913;87683;67232.6638366805;69810.9528357075;71019.64490177516;73115.63442182861;73472.26527734761;7897.4076944230565;8475.194856488624;8626;8770.561471926505;8853;31999.20011998219;37122.44316335311;44610.330845038;44912.32631510595;46008.53991460043;38320.6167938317;44986.10027799491;60920.39079609147;61681.38318616936;61974.38025619686;10463.476826158509;10768.46157692128;10771;10920.071793897609;11526.88473115258;9997.800043999225;11121;13047.347632618521;13315.600531983668;14229.217393043482;11409.144314176636;11686.474108664961;11696.70758231051;12288.877111228774;12828.230306181658;10510.264281500222;10544.736381590521;10759.031687148194;10862.728431789268;11374.20380573352;10928.562857485611;11646.475908584303;11647.6505704829;11826.46780894879;11855.822162667395;10039.749006274902;10197.898021019695;10259.846102308322;10298.279120461495;10833.187510936554;9441.669541566012;9704.417734935927;10150.847737284093;10166.805380432745;10270.435126068138 16:31:47 INFO - PROCESS | 11891 | __end_tp_report 16:31:47 INFO - PROCESS | 11891 | __start_cc_report 16:31:47 INFO - PROCESS | 11891 | _x_x_mozilla_cycle_collect,1057 16:31:47 INFO - PROCESS | 11891 | __end_cc_report 16:31:47 INFO - PROCESS | 11891 | __startTimestamp1471303907919__endTimestamp 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | ------- Summary: start ------- 16:31:47 INFO - PROCESS | 11891 | Number of tests: 6 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | [#0] dojo.html Cycles:165 Average:4786.00 Median:4965.80 stddev:511.89 (10.3%) stddev-sans-first:484.86 16:31:47 INFO - PROCESS | 11891 | Values: 2635.4 2668.4 2674.4 2698.2 2699.5 4716.3 4773.9 4819.4 4839.4 4841.4 4759.8 4782.0 4833.3 4845.5 4847.7 4356.3 4407.1 4411.3 4467.3 4566.4 4500.0 4531.2 4564.5 4568.9 4577.2 4253.9 4319.2 4460.1 4492.1 4565.2 4357.7 4365.4 4396.0 4439.4 4461.6 4335.5 4362.2 4395.6 4397.1 4404.4 4807.4 4815.5 4847.4 4856.4 4865.9 4972.4 5081.0 5135.2 5151.2 5168.2 5250.7 5260.0 5261.2 5262.3 5270.9 4653.0 4879.8 4887.2 4888.1 4892.7 5209.9 5265.2 5276.9 5339.7 5363.1 5036.4 5056.9 5099.0 5106.2 5112.2 5008.3 5180.7 5220.0 5221.7 5236.1 5007.6 5071.9 5080.9 5118.2 5165.6 5111.6 5118.6 5118.7 5119.9 5155.4 4214.8 4326.2 4333.5 4333.6 4376.6 3733.9 3754.5 3789.1 3822.1 3869.4 4485.5 4511.3 4515.4 4551.3 4557.1 5219.3 5225.2 5227.5 5237.4 5241.3 4370.1 4453.7 4498.3 4516.1 4585.4 4651.0 4678.9 4684.4 4686.7 4732.6 4936.2 4965.8 4978.9 4980.8 5022.7 5009.7 5108.1 5178.3 5182.8 5257.8 4908.7 4943.7 4944.2 4947.7 4980.5 5103.6 5109.3 5111.1 5112.1 5114.5 5039.1 5128.9 5196.9 5200.9 5277.8 5087.3 5093.6 5096.2 5098.8 5103.4 5091.7 5098.0 5098.2 5101.6 5123.6 4815.9 4916.8 4967.3 4995.4 5063.4 5100.0 5111.8 5116.6 5117.9 5158.5 4970.6 5001.1 5008.3 5017.2 5017.5 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | [#1] ext.html Cycles:180 Average:43910.01 Median:3614.87 stddev:76258.00 (2109.6%) stddev-sans-first:76402.52 16:31:47 INFO - PROCESS | 11891 | Values: 576.4 584.8 588.1 588.1 588.4 28724.9 38905.4 39776.6 39798.4 43566.6 39485.0 40037.6 40038.2 40054.4 40097.2 7660.0 7786.6 7791.8 7797.8 7800.9 7537.7 7607.7 7615.2 7618.2 7623.0 7618.2 7645.0 7652.3 7660.2 7660.4 7576.5 7622.7 7626.2 7626.4 7629.5 7582.1 7653.2 7655.2 7658.2 7669.7 36928.8 37350.6 37429.6 37443.3 37463.8 3163.4 3191.2 3280.5 3366.0 3565.6 27112.7 29299.0 29555.1 29565.7 29649.4 3386.1 3405.8 3570.6 3607.3 3622.5 246207.0 246761.0 247571.0 247590.0 248466.0 51421.7 51816.2 51822.5 51919.5 52112.0 55061.7 55150.2 55175.4 55234.7 55279.0 13301.2 13479.3 13485.9 13488.7 13489.1 10226.7 10235.7 10301.1 10318.2 10332.0 14565.4 16571.3 16619.3 16632.4 16638.5 4714.1 5226.9 5394.1 5437.2 5553.7 756.3 855.9 858.4 863.6 913.9 26203.7 27755.0 28257.9 28263.1 28450.9 937.5 956.5 982.6 997.6 1016.1 14181.9 15054.0 15069.9 15251.8 15328.3 373801.0 374535.0 375614.0 376627.0 377024.0 49047.8 49240.8 49306.5 49335.5 49405.5 1072.4 1106.5 1130.9 1167.6 1179.2 24441.5 28147.3 28766.1 29476.4 29550.6 41417.2 41970.6 42000.4 42013.4 42017.0 222192.0 222701.0 223599.0 224258.0 224622.0 24207.3 25256.2 25270.4 26179.7 26258.5 40492.6 40770.0 40814.8 41909.0 41956.8 34352.0 34444.5 34583.0 34885.8 34990.0 34404.0 34431.5 34541.3 34550.8 34681.3 32694.7 33356.2 33473.0 34628.1 34995.5 30130.5 32592.2 32681.7 32761.5 32822.3 24888.9 25261.2 25367.2 25534.0 25574.2 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | [#2] jquery.html Cycles:180 Average:23750.12 Median:27058.75 stddev:62279.06 (230.2%) stddev-sans-first:62428.99 16:31:47 INFO - PROCESS | 11891 | Values: 350.5 366.0 377.5 377.5 392.7 12860.6 16129.1 16376.0 16513.7 17635.2 16373.9 16727.8 16908.4 17361.5 17516.6 4916.2 4953.8 5060.4 5098.2 5098.9 3778.9 5052.6 5136.6 5684.0 5996.3 5995.7 6014.3 6014.7 6023.6 6029.2 5162.1 5454.5 5475.7 5484.5 6006.0 5298.2 5303.9 5310.4 5310.6 5316.4 19022.8 19907.9 20231.4 20670.5 20782.6 1901.1 1916.1 1948.9 1958.3 2084.3 9037.6 9277.0 9705.4 9767.4 9840.4 1672.2 1720.0 1722.3 1777.5 1817.0 63758.0 68377.0 68385.3 69089.0 69710.0 9796.1 9992.9 9994.3 10218.4 10423.3 13633.7 13634.0 13641.6 13647.5 13672.2 6696.9 6828.8 6853.5 7008.4 7087.4 6295.5 6336.4 6492.1 6499.9 6507.8 4244.5 4294.9 4315.0 4424.8 4443.4 1748.9 1821.7 1830.9 1850.4 1858.5 784.8 815.7 876.4 883.7 947.5 16309.1 16923.4 17118.5 17457.8 17693.2 855.7 862.4 863.3 890.4 925.9 9129.5 9768.1 9790.2 9795.3 9838.3 366840.0 369870.0 382012.0 383921.0 385148.0 66886.7 67957.7 71694.6 73112.3 74928.0 910.3 911.8 948.3 950.4 959.0 15864.3 15903.4 16013.0 16530.1 16917.8 26993.9 31901.7 34140.5 38246.0 38881.6 49201.3 52681.5 53330.0 53635.2 54446.5 7432.4 7448.4 7549.5 7655.8 7798.1 10999.9 11966.5 12043.4 12214.1 12299.6 9604.9 9761.5 10993.6 11032.1 11095.0 10670.3 10757.7 10834.7 10899.4 11002.2 10440.6 10786.6 10971.2 11154.9 11530.1 7414.0 7685.2 7696.3 7701.9 7936.4 9480.7 10038.7 10110.8 10119.2 10212.8 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | [#3] mootools.html Cycles:180 Average:5024.09 Median:4835.36 stddev:2888.08 (59.7%) stddev-sans-first:2881.99 16:31:47 INFO - PROCESS | 11891 | Values: 1214.8 1325.7 1359.7 1367.9 1606.8 6614.9 7404.3 7648.9 7652.6 7875.8 7726.6 7791.6 7795.3 7798.9 7813.3 2174.8 2200.4 2200.8 2204.3 2205.6 2127.8 2152.9 2181.4 2181.5 2187.5 2118.8 2140.5 2150.3 2152.6 2173.4 2106.6 2114.2 2114.6 2114.7 2116.5 2031.6 2107.4 2108.0 2111.4 2115.2 7728.0 7873.3 7880.6 7887.9 7890.6 4404.4 4566.8 4568.5 4576.5 4588.5 2671.4 2770.9 2813.4 2820.6 2826.8 866.0 882.7 883.8 885.9 890.9 10778.9 10900.1 10943.7 10961.9 10965.3 3808.7 3941.6 4094.7 4101.3 4128.6 8391.0 8415.4 8417.9 8429.8 8449.9 4562.6 4572.7 4575.4 4579.7 4585.3 3650.1 4011.9 4194.3 4287.2 4313.0 3352.1 3376.5 3490.4 3501.9 3524.4 1011.9 1021.1 1023.8 1032.2 1063.4 662.6 787.6 802.8 825.5 835.2 4863.7 4878.3 4917.8 4966.7 5095.1 388.1 402.5 402.5 405.1 406.5 3347.8 3503.7 3568.4 3580.2 3588.5 9128.6 9522.5 9598.4 9615.9 9687.4 9446.0 9473.6 9487.4 9509.7 9539.3 7296.3 7340.3 7347.4 7351.7 7352.0 4831.2 4839.5 4916.2 4969.6 5047.2 8902.6 8902.7 8931.6 8994.4 9045.8 8490.7 8636.0 8718.7 9131.0 9178.4 5683.7 5995.5 6688.3 6786.8 6821.7 7313.3 7539.0 7544.1 7547.5 7550.6 6597.5 6716.8 6741.7 6777.3 6881.7 6651.7 6677.3 6782.8 6806.6 6837.5 5898.4 5997.6 5998.7 6005.7 6011.4 4358.5 4364.4 4405.2 4416.9 4567.0 4376.3 4444.9 4525.9 4616.6 4619.8 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | [#4] prototype.html Cycles:180 Average:4263.21 Median:4910.14 stddev:1246.07 (25.4%) stddev-sans-first:1213.57 16:31:47 INFO - PROCESS | 11891 | Values: 301.9 302.4 308.5 310.9 311.1 4878.8 4926.2 4929.8 4961.9 4989.9 4807.7 4829.7 4912.0 4912.3 4914.9 3652.6 3786.4 3791.4 3841.1 3861.6 3843.9 3850.6 3852.3 3855.6 3865.0 3800.7 3804.0 3812.2 3818.3 3824.7 3626.8 3665.7 3795.3 3824.9 3852.9 3403.4 3405.2 3409.6 3412.2 3413.4 4820.8 4823.4 4828.0 4833.0 4854.4 4103.6 4332.8 4416.3 4422.5 4423.9 5090.2 5097.7 5128.8 5143.0 5152.2 3630.9 3634.0 3635.2 3635.5 3647.5 5086.5 5255.0 5349.2 5364.4 5380.4 3634.9 3683.8 3690.2 3699.9 3710.4 3759.0 3762.6 3766.0 3772.5 3776.2 4290.7 4309.9 4311.8 4313.5 4324.1 4875.8 5084.5 5085.4 5132.7 5143.7 1282.2 1303.9 1305.8 1318.2 1319.2 780.3 813.7 817.4 817.6 823.6 4455.0 4527.8 4587.8 4594.4 4610.0 5291.2 5299.9 5304.2 5305.0 5343.8 4398.3 4557.9 4561.0 4566.0 4614.7 2770.0 2784.5 2787.1 2789.8 2806.2 4979.2 4987.8 5051.9 5056.9 5071.3 5105.3 5310.2 5419.6 5430.1 5431.5 4956.3 5003.4 5006.8 5011.5 5023.6 5301.9 5320.2 5326.8 5344.0 5347.5 5027.4 5129.7 5170.5 5185.9 5186.2 4969.8 5056.8 5062.0 5063.3 5072.4 3716.6 3749.3 3766.2 3766.9 3770.2 5186.3 5208.5 5278.8 5343.2 5355.1 5064.9 5087.6 5180.1 5192.3 5203.1 5146.2 5177.4 5185.9 5200.9 5203.5 4898.3 5020.1 5045.5 5081.2 5089.8 4908.3 4999.5 5090.6 5146.5 5160.9 5032.8 5035.0 5061.3 5088.7 5106.0 16:31:47 INFO - PROCESS | 11891 | 16:31:47 INFO - PROCESS | 11891 | [#5] yui.html Cycles:180 Average:17258.85 Median:4082.89 stddev:24318.61 (595.6%) stddev-sans-first:24354.81 16:31:47 INFO - PROCESS | 11891 | Values: 640.7 665.9 668.5 671.7 728.3 11133.0 12794.2 13479.0 13889.8 13890.6 13944.7 14064.4 14741.8 14745.0 14758.4 761.3 773.0 780.1 780.6 780.6 629.2 758.3 775.2 776.0 776.2 818.8 826.4 828.0 828.5 828.6 822.4 822.5 822.8 822.9 823.0 597.9 598.6 598.7 598.9 599.0 12976.2 13105.4 13319.3 13471.6 13553.0 13316.4 13578.2 13760.9 13835.2 14080.6 9999.5 10137.8 10250.5 10358.3 10452.4 3304.6 3315.2 3316.4 3335.9 3347.0 66123.3 67249.3 68787.0 70345.3 71225.3 10376.4 10529.4 10614.6 10657.7 10666.5 19579.9 19931.2 19946.3 19954.2 19992.5 6460.1 6908.1 6951.3 6958.3 7338.2 3736.5 3800.4 3822.8 3836.5 4008.0 2848.2 2934.4 3280.9 3440.4 3469.8 551.3 564.8 566.2 567.3 569.4 459.4 482.7 508.2 512.3 564.4 7484.8 7844.4 7906.4 7981.6 8122.3 459.6 462.8 502.6 528.9 561.7 3538.2 3789.5 3958.3 3976.3 4157.8 57436.0 98178.5 100286.0 102510.0 103252.0 67981.7 75739.6 79562.6 79913.0 87683.0 67232.7 69811.0 71019.6 73115.6 73472.3 7897.4 8475.2 8626.0 8770.6 8853.0 31999.2 37122.4 44610.3 44912.3 46008.5 38320.6 44986.1 60920.4 61681.4 61974.4 10463.5 10768.5 10771.0 10920.1 11526.9 9997.8 11121.0 13047.3 13315.6 14229.2 11409.1 11686.5 11696.7 12288.9 12828.2 10510.3 10544.7 10759.0 10862.7 11374.2 10928.6 11646.5 11647.7 11826.5 11855.8 10039.7 10197.9 10259.8 10298.3 10833.2 9441.7 9704.4 10150.8 10166.8 10270.4 16:31:47 INFO - PROCESS | 11891 | -------- Summary: end -------- 16:31:47 INFO - PROCESS | 11891 | 16:31:48 INFO - TEST-INFO | 11891: exit 0 16:31:48 INFO - TEST-OK | dromaeo_css | took 1121391ms 16:31:48 INFO - TEST-START | kraken 16:31:48 INFO - operating with platform_type : linux_ 16:31:48 INFO - Initialising browser for kraken test... 16:31:48 INFO - TEST-INFO | started process 12201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwl3K2d/profile http://localhost:55662/getInfo.html) 16:31:53 INFO - PROCESS | 12201 | __metrics Screen width/height:1600/1200 16:31:53 INFO - PROCESS | 12201 | colorDepth:24 16:31:53 INFO - PROCESS | 12201 | Browser inner width/height: 1024/697 16:31:53 INFO - PROCESS | 12201 | __metrics 16:31:54 INFO - PROCESS | 12201 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:31:54 INFO - PROCESS | 12201 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:31:55 INFO - PROCESS | 12201 | console.error: PushService: 16:31:55 INFO - PROCESS | 12201 | stateChangeProcessEnqueue: Error transitioning state 16:31:55 INFO - PROCESS | 12201 | UnknownError 16:31:55 INFO - TEST-INFO | 12201: exit 0 16:31:55 INFO - Browser initialized. 16:31:55 INFO - Running cycle 1/1 for kraken test... 16:31:55 INFO - TEST-INFO | started process 12280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwl3K2d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:07 INFO - PROCESS | 12280 | RSS: Main: 156975104 16:32:07 INFO - PROCESS | 12280 | 16:32:10 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:11 INFO - PROCESS | 12280 | RSS: Main: 204443648 16:32:11 INFO - PROCESS | 12280 | 16:32:14 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-dft) 16:32:14 INFO - PROCESS | 12280 | RSS: Main: 196136960 16:32:14 INFO - PROCESS | 12280 | 16:32:17 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-fft) 16:32:18 INFO - PROCESS | 12280 | RSS: Main: 277782528 16:32:18 INFO - PROCESS | 12280 | 16:32:20 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-oscillator) 16:32:21 INFO - PROCESS | 12280 | RSS: Main: 188035072 16:32:21 INFO - PROCESS | 12280 | 16:32:23 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:24 INFO - PROCESS | 12280 | RSS: Main: 192135168 16:32:24 INFO - PROCESS | 12280 | 16:32:27 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55662/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:27 INFO - PROCESS | 12280 | RSS: Main: 228622336 16:32:27 INFO - PROCESS | 12280 | 16:32:31 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55662/tests/kraken/driver.html?testName=imaging-desaturate) 16:32:32 INFO - PROCESS | 12280 | RSS: Main: 222236672 16:32:32 INFO - PROCESS | 12280 | 16:32:35 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55662/tests/kraken/driver.html?testName=json-parse-financial) 16:32:35 INFO - PROCESS | 12280 | RSS: Main: 225923072 16:32:35 INFO - PROCESS | 12280 | 16:32:37 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:37 INFO - PROCESS | 12280 | RSS: Main: 189239296 16:32:37 INFO - PROCESS | 12280 | 16:32:39 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:40 INFO - PROCESS | 12280 | RSS: Main: 196980736 16:32:40 INFO - PROCESS | 12280 | 16:32:42 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:43 INFO - PROCESS | 12280 | RSS: Main: 193814528 16:32:43 INFO - PROCESS | 12280 | 16:32:46 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:46 INFO - PROCESS | 12280 | RSS: Main: 189423616 16:32:46 INFO - PROCESS | 12280 | 16:32:49 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:50 INFO - PROCESS | 12280 | RSS: Main: 191766528 16:32:50 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55662/tests/kraken/driver.html?testName=ai-astar) 16:32:52 INFO - PROCESS | 12280 | RSS: Main: 242671616 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | __start_tp_report 16:32:52 INFO - PROCESS | 12280 | _x_x_mozilla_page_load 16:32:52 INFO - PROCESS | 12280 | _x_x_mozilla_page_load_details 16:32:52 INFO - PROCESS | 12280 | |i|pagename|runs| 16:32:52 INFO - PROCESS | 12280 | |0;ai-astar;108;115;115;114;111;113;114;114;115;113 16:32:52 INFO - PROCESS | 12280 | |1;audio-beat-detection;155;122;129;179;123;126;152;126;181;132 16:32:52 INFO - PROCESS | 12280 | |2;audio-dft;162;162;162;161;162;162;162;161;161;160 16:32:52 INFO - PROCESS | 12280 | |3;audio-fft;75;76;76;123;78;77;76;77;126;77 16:32:52 INFO - PROCESS | 12280 | |4;audio-oscillator;87;87;128;86;86;86;116;86;86;120 16:32:52 INFO - PROCESS | 12280 | |5;imaging-gaussian-blur;116;117;117;118;118;118;117;117;118;117 16:32:52 INFO - PROCESS | 12280 | |6;imaging-darkroom;146;145;146;146;145;146;146;145;145;146 16:32:52 INFO - PROCESS | 12280 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 16:32:52 INFO - PROCESS | 12280 | |8;json-parse-financial;63;62;65;63;63;66;64;63;64;69 16:32:52 INFO - PROCESS | 12280 | |9;json-stringify-tinderbox;66;66;65;65;66;66;66;65;65;67 16:32:52 INFO - PROCESS | 12280 | |10;stanford-crypto-aes;98;82;83;84;83;89;87;82;82;82 16:32:52 INFO - PROCESS | 12280 | |11;stanford-crypto-ccm;134;145;143;130;132;134;132;131;149;135 16:32:52 INFO - PROCESS | 12280 | |12;stanford-crypto-pbkdf2;172;173;184;176;171;176;172;174;173;177 16:32:52 INFO - PROCESS | 12280 | |13;stanford-crypto-sha256-iterative;76;69;67;68;68;68;67;71;68;68 16:32:52 INFO - PROCESS | 12280 | __end_tp_report 16:32:52 INFO - PROCESS | 12280 | __start_cc_report 16:32:52 INFO - PROCESS | 12280 | _x_x_mozilla_cycle_collect,1966 16:32:52 INFO - PROCESS | 12280 | __end_cc_report 16:32:52 INFO - PROCESS | 12280 | __startTimestamp1471303972303__endTimestamp 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | ------- Summary: start ------- 16:32:52 INFO - PROCESS | 12280 | Number of tests: 14 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:2.20 (1.9%) stddev-sans-first:1.30 16:32:52 INFO - PROCESS | 12280 | Values: 108.0 115.0 115.0 114.0 111.0 113.0 114.0 114.0 115.0 113.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:142.00 stddev:22.85 (16.1%) stddev-sans-first:23.78 16:32:52 INFO - PROCESS | 12280 | Values: 155.0 122.0 129.0 179.0 123.0 126.0 152.0 126.0 181.0 132.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 16:32:52 INFO - PROCESS | 12280 | Values: 162.0 162.0 162.0 161.0 162.0 162.0 162.0 161.0 161.0 160.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#3] audio-fft Cycles:10 Average:86.10 Median:76.50 stddev:20.27 (26.5%) stddev-sans-first:21.10 16:32:52 INFO - PROCESS | 12280 | Values: 75.0 76.0 76.0 123.0 78.0 77.0 76.0 77.0 126.0 77.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:86.00 stddev:17.18 (20.0%) stddev-sans-first:17.85 16:32:52 INFO - PROCESS | 12280 | Values: 87.0 87.0 128.0 86.0 86.0 86.0 116.0 86.0 86.0 120.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 16:32:52 INFO - PROCESS | 12280 | Values: 116.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:32:52 INFO - PROCESS | 12280 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:32:52 INFO - PROCESS | 12280 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:2.04 (3.2%) stddev-sans-first:2.12 16:32:52 INFO - PROCESS | 12280 | Values: 63.0 62.0 65.0 63.0 63.0 66.0 64.0 63.0 64.0 69.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:32:52 INFO - PROCESS | 12280 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 66.0 65.0 65.0 67.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.50 stddev:5.09 (6.1%) stddev-sans-first:2.54 16:32:52 INFO - PROCESS | 12280 | Values: 98.0 82.0 83.0 84.0 83.0 89.0 87.0 82.0 82.0 82.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:134.50 stddev:6.65 (4.9%) stddev-sans-first:7.00 16:32:52 INFO - PROCESS | 12280 | Values: 134.0 145.0 143.0 130.0 132.0 134.0 132.0 131.0 149.0 135.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:3.79 (2.2%) stddev-sans-first:3.89 16:32:52 INFO - PROCESS | 12280 | Values: 172.0 173.0 184.0 176.0 171.0 176.0 172.0 174.0 173.0 177.0 16:32:52 INFO - PROCESS | 12280 | 16:32:52 INFO - PROCESS | 12280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.00 stddev:2.71 (4.0%) stddev-sans-first:1.20 16:32:52 INFO - PROCESS | 12280 | Values: 76.0 69.0 67.0 68.0 68.0 68.0 67.0 71.0 68.0 68.0 16:32:52 INFO - PROCESS | 12280 | -------- Summary: end -------- 16:32:52 INFO - PROCESS | 12280 | 16:32:53 INFO - TEST-INFO | 12280: exit 0 16:32:53 INFO - TEST-OK | kraken | took 65007ms 16:32:53 INFO - SUITE-END | took 1186s 16:32:53 INFO - Completed test suite (00:19:46) 16:32:53 INFO - javascript benchmark 16:32:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.367511797169, 2668.4262883480046, 2674.438367942732, 2698.177055997921, 2699.514087464257, 4716.268978308368, 4773.856784296468, 4819.373481447411, 4839.443464001641, 4841.39482564679, 4759.785809638566, 4781.952180478194, 4833.32333473314, 4845.491223421534, 4847.684900481467, 4356.281213599752, 4407.11857628474, 4411.338299255105, 4467.285234362503, 4566.40636717228, 4500.032493014001, 4531.229690952546, 4564.497905230422, 4568.9491416974115, 4577.153226653063, 4253.914921701579, 4319.244132276839, 4460.085682435093, 4492.101579684077, 4565.223911934979, 4357.694961352707, 4365.388845561624, 4396.0, 4439.356293337481, 4461.643068554507, 4335.544767799367, 4362.214801335758, 4395.582419670126, 4397.054633253866, 4404.4494438195225, 4807.351007613962, 4815.542523460265, 4847.442544107403, 4856.417229932431, 4865.854024379274, 4972.353594032788, 5081.034603425337, 5135.204043373245, 5151.201563757623, 5168.198929165986, 5250.7374631268285, 5259.973700131513, 5261.184516399964, 5262.342207224097, 5270.92093618596, 4652.976735116303, 4879.829205977774, 4887.169181239198, 4888.071266459361, 4892.657513974059, 5209.947900521022, 5265.210218467184, 5276.868078298074, 5339.7063161526485, 5363.088274993261, 5036.370453693288, 5056.898862022739, 5099.0, 5106.234064890222, 5112.207607820794, 5008.29883816266, 5180.663256888291, 5219.973900130475, 5221.66059206158, 5236.1098613235845, 5007.574356179693, 5071.898562028812, 5080.949190508121, 5118.206677964921, 5165.612579056586, 5111.591072714174, 5118.564921981599, 5118.718470484159, 5119.897602047939, 5155.355580552431, 4214.831406743696, 4326.242907491176, 4333.544977777288, 4333.6316413104605, 4376.627986621109, 3733.8506459741848, 3754.511913451234, 3789.052736815796, 3822.0827001519992, 3869.4389313549377, 4485.506594274627, 4511.3458548510935, 4515.390422292949, 4551.294549344857, 4557.08858228349, 5219.321488206509, 5225.242339860699, 5227.529522342931, 5237.371515418175, 5241.266222728821, 4370.147821174841, 4453.710508816916, 4498.302763071729, 4516.119356725473, 4585.426821647294, 4651.0, 4678.883027924261, 4684.367610372556, 4686.74222917736, 4732.621390288768, 4936.185529387611, 4965.801367945314, 4978.925316120333, 4980.800767969241, 5022.698638081727, 5009.749512524432, 5108.131617624938, 5178.326817513699, 5182.792688292426, 5257.842264732064, 4908.680935739166, 4943.728094954812, 4944.233643785219, 4947.727874966911, 4980.477049909852, 5103.617228707936, 5109.259157422079, 5111.05445492585, 5112.054269960069, 5114.514121158484, 5039.118154323052, 5128.897422051613, 5196.896062078662, 5200.869978250574, 5277.762500687555, 5087.3386459759995, 5093.592512599057, 5096.210087436453, 5098.847034588968, 5103.4386217516785, 5091.66904151229, 5097.974510127426, 5098.1588037973315, 5101.642884998015, 5123.615728820428, 4815.879603009813, 4916.803327866988, 4967.3045773591, 4995.400551933792, 5063.417706963599, 5099.974500127476, 5111.795528178831, 5116.641835071509, 5117.92323115161, 5158.484151584811, 4970.627202959865, 5001.149804533311, 5008.273800299009, 5017.1721665924715, 5017.4731653175895], "value": 4752.542013283188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.4005434348278, 584.763170915779, 588.0561698473949, 588.0913987888712, 588.3939542271462, 28724.85637571812, 38905.41641875374, 39776.602233977654, 39798.40302395466, 43566.56433435665, 39485.0, 40037.59962400375, 40038.199236015265, 40054.39918401219, 40097.198056038935, 7660.004199454077, 7786.571738554378, 7791.8052048698955, 7797.844043119134, 7800.921990780076, 7537.736179233728, 7607.695692172307, 7615.200403957588, 7618.200088990659, 7623.047119110111, 7618.200088990659, 7644.961775191116, 7652.31129198372, 7660.157382687928, 7660.387169026492, 7576.469647124703, 7622.656980435893, 7626.237376262329, 7626.351760100398, 7629.504082234693, 7582.128055273603, 7653.234676532302, 7655.196204398514, 7658.157602663702, 7669.6932122715025, 36928.81535592332, 37350.626493734984, 37429.62570374289, 37443.251134977145, 37463.812680936695, 3163.43058249515, 3191.2021994501374, 3280.475123980176, 3366.040678406642, 3565.5899571549085, 27112.728872711414, 29299.0, 29555.113346599635, 29565.70434295651, 29649.407011859857, 3386.0857568456627, 3405.8297085145646, 3570.5715314162208, 3607.2785442911522, 3622.4566315052953, 246206.9999999982, 246761.0, 247571.0, 247590.0, 248466.0, 51421.742891286056, 51816.22275665868, 51822.48177518177, 51919.48080519222, 52112.0, 55061.72469137629, 55150.17274740882, 55175.44824551703, 55234.723826380614, 55279.0, 13301.201927884164, 13479.326033698277, 13485.865141348657, 13488.662783430493, 13489.055766096475, 10226.693199203886, 10235.7441063974, 10301.124404425707, 10318.1745460363, 10332.0, 14565.41738330455, 16571.337146514245, 16619.3352265908, 16632.417865374653, 16638.504224366443, 4714.124619112717, 5226.869328266824, 5394.136938089887, 5437.238786569884, 5553.72231388437, 756.3268690865134, 855.8587833007484, 858.3948316436897, 863.6459051788736, 913.9131782480654, 26203.73796262051, 27755.0, 28257.858710706725, 28263.072155117577, 28450.857745711553, 937.4515908193647, 956.4596003258137, 982.6069572171189, 997.576030187182, 1016.1312078173204, 14181.85818141826, 15054.0, 15069.924650376677, 15251.771223431657, 15328.310226039855, 373801.0, 374535.0, 375614.0, 376627.0, 377024.0, 49047.75476122668, 49240.75379623079, 49306.50693493091, 49335.50664493381, 49405.50594494009, 1072.3619446429361, 1106.5186643809968, 1130.8529891114104, 1167.5738355500182, 1179.2452830188686, 24441.533507989578, 28147.296317592223, 28766.137015889555, 29476.410471790874, 29550.556741648463, 41417.171656567305, 41970.58029419667, 42000.369994449495, 42013.36979945364, 42017.0, 222192.0, 222701.0, 223599.0, 224258.0, 224622.0, 24207.273781786575, 25256.242312730647, 25270.368240794127, 26179.727534058242, 26258.474830502902, 40492.59507405006, 40770.0, 40814.79592602018, 41909.0, 41956.79021604872, 34352.0, 34444.48333274953, 34583.0, 34885.82557087198, 34990.0, 34404.0, 34431.483527746605, 34541.30917381689, 34550.82724586361, 34681.30637387188, 32694.67305326916, 33356.166095847795, 33473.0, 34628.13429664178, 34995.47506787349, 30130.54804177895, 32592.185195370304, 32681.673183267863, 32761.508577371835, 32822.34355312928, 24888.875555622108, 25261.242162735147, 25367.238982830546, 25534.0, 25574.23277301684], "value": 16909.672825839527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.49178690898174, 365.9798711070892, 377.46023186842814, 377.54505820486315, 392.7113571524929, 12860.614181574556, 16129.112898790561, 16376.0, 16513.66972660546, 17635.20641571129, 16373.91813040933, 16727.83272167278, 16908.408205712803, 17361.47915562532, 17516.64966700665, 4916.237983112624, 4953.801847926079, 5060.367454068241, 5098.184290513518, 5098.872528186806, 3778.905527361824, 5052.595792336622, 5136.64043516954, 5684.0, 5996.2804463464445, 5995.6702381369005, 6014.308354539218, 6014.729337179838, 6023.638581685091, 6029.21620189377, 5162.096633089213, 5454.481824226692, 5475.67145971239, 5484.451554844523, 6006.0, 5298.178782288752, 5303.867403314909, 5310.389305229909, 5310.60170487215, 5316.415194328621, 19022.80977190224, 19907.90046049775, 20231.393058208276, 20670.483237919023, 20782.5843483131, 1901.0589758069705, 1916.089857317777, 1948.8733232339853, 1958.3341663834365, 2084.333013435701, 9037.593308301142, 9277.0, 9705.369151005161, 9767.365121267096, 9840.3603765755, 1672.2474886301213, 1719.9828001719948, 1722.2766438095905, 1777.5022993561824, 1816.9909150454296, 63758.0, 68377.0, 68385.31614683839, 69088.96366554455, 69710.0, 9796.118349348593, 9992.900070999198, 9994.250431217688, 10218.437985910847, 10423.270371074104, 13633.727325453436, 13634.0, 13641.590752277447, 13647.522336718168, 13672.179669219879, 6696.86606267872, 6828.760993365208, 6853.520253582301, 7008.369246767816, 7087.397571206505, 6295.496360291166, 6336.398042185985, 6492.123563318892, 6499.8700025999215, 6507.804765857032, 4244.490661120685, 4294.871153865389, 4314.9784251078545, 4424.756638384855, 4443.422355093881, 1748.930042798274, 1821.6629923464202, 1830.880992735468, 1850.3616252392903, 1858.461046296586, 784.8430313937235, 815.6941147069849, 876.4084243135858, 883.6862913665556, 947.5404428852002, 16309.102999334913, 16923.37687658415, 17118.48644540666, 17457.825421745874, 17693.20380582877, 855.683397143061, 862.4006315610591, 863.3093525179831, 890.3589415620743, 925.9212966897754, 9129.543522823833, 9768.120869121813, 9790.21678265737, 9795.265355098396, 9838.262130340254, 366840.0, 369870.0, 382012.0, 383921.0, 385148.0, 66886.66556667186, 67957.66021169961, 71694.64152679204, 73112.26887731161, 74928.0, 910.2899738204344, 911.7857303533664, 948.3456415073578, 950.4392408478892, 959.0170075672492, 15864.286107124975, 15903.433798170548, 16013.0, 16530.09084500316, 16917.830821691627, 26993.865030674722, 31901.68098318987, 34140.487892682126, 38246.0, 38881.6111838878, 49201.2619810696, 52681.473185267656, 53330.0, 53635.19547206873, 54446.455535445726, 7432.405407567489, 7448.441366897396, 7549.547027178387, 7655.846883062419, 7798.142204357403, 10999.890001099886, 11966.521339146684, 12043.397830108635, 12214.14500984958, 12299.569515067287, 9604.903950960681, 9761.463119528495, 10993.560257589606, 11032.117430605693, 11095.0, 10670.30643008202, 10757.677269681923, 10834.729131771768, 10899.400532970445, 11002.174836887105, 10440.63457778974, 10786.622468213574, 10971.23201375896, 11154.944225278821, 11530.135239856876, 7414.0, 7685.154632990255, 7696.307332340116, 7701.92298077012, 7936.444448888522, 9480.715578532656, 10038.749031274276, 10110.848337275094, 10119.241056920613, 10212.795744085226], "value": 8197.229765867727, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.8359971403859, 1325.7083441642835, 1359.6532884114552, 1367.8974076944226, 1606.8473495017977, 6614.8677026459445, 7404.296591823775, 7648.923510764891, 7652.617369131542, 7875.8424831503335, 7726.61366931654, 7791.610419479018, 7795.298423141916, 7798.883016754753, 7813.257740514656, 2174.7933946275116, 2200.427888748921, 2200.7909248621436, 2204.2836078274627, 2205.5588882223537, 2127.7659457459745, 2152.8600640958366, 2181.3892110209167, 2181.5418762059985, 2187.4968757185857, 2118.8199003084756, 2140.454184183031, 2150.258160934475, 2152.6340522111277, 2173.402314363547, 2106.5681535285307, 2114.217739436403, 2114.5982263370065, 2114.661654135331, 2116.460302622837, 2031.5936812637383, 2107.4204593736845, 2108.040841417167, 2111.419359676086, 2115.2173695732677, 7728.0, 7873.330766884822, 7880.605969701492, 7887.921120788834, 7890.56601886896, 4404.383386325917, 4566.817327306904, 4568.474625418086, 4576.45082590088, 4588.541145885385, 2671.3989352395556, 2770.8614569271454, 2813.43731253748, 2820.591014302935, 2826.802123851331, 865.9523726195057, 882.668999125328, 883.7834730491006, 885.9202671759573, 890.9420887642283, 10778.946105269502, 10900.1279897608, 10943.726406839813, 10961.945190274077, 10965.287256328313, 3808.6762625176616, 3941.625545573166, 4094.733842300241, 4101.282275601758, 4128.6284234419045, 8390.958045209734, 8415.368847336475, 8417.873731894026, 8429.789255268544, 8449.915500845036, 4562.634989200856, 4572.702774319659, 4575.3823233863, 4579.6794224403975, 4585.266357382803, 3650.0874781304674, 4011.8796436106963, 4194.3498757692605, 4287.185434767384, 4312.978435107867, 3352.1116904020455, 3376.544166537535, 3490.406630872707, 3501.8949431516585, 3524.4360902255517, 1011.9190464762802, 1021.0810270756378, 1023.8003589300164, 1032.1587905856702, 1063.4151216830712, 662.592505609047, 787.6180052674448, 802.8314054048599, 825.4593241426875, 835.1856939483954, 4863.7324947128245, 4878.317035615017, 4917.827876024322, 4966.726830024311, 5095.108356037678, 388.12671489149415, 402.4607026584391, 402.4807997683015, 405.0885507607882, 406.520306038877, 3347.7991320520846, 3503.7197024238, 3568.3933731265747, 3580.230250496104, 3588.461730740358, 9128.58921348541, 9522.52387380642, 9598.376105553116, 9615.9038409615, 9687.418754874589, 9446.0, 9473.573689184002, 9487.430754154773, 9509.714708558755, 9539.3322467428, 7296.306850849161, 7340.302671246223, 7347.412207023533, 7351.705931762776, 7352.007478990268, 4831.227003679394, 4839.491853355347, 4916.213405855046, 4969.627277954096, 5047.192449208256, 8902.59938302765, 8902.688405905763, 8931.598078086372, 8994.370394072352, 9045.819083618422, 8490.702825401082, 8636.0, 8718.65125394977, 9131.0, 9178.449293042439, 5683.744231509675, 5995.490383317292, 6688.264290927897, 6786.830329241809, 6821.727130914708, 7313.305236002571, 7538.962305188439, 7544.132424771002, 7547.490501899532, 7550.622468876644, 6597.538172327891, 6716.798496045127, 6741.696623652046, 6777.322267773183, 6881.65591720422, 6651.73393064272, 6677.29888361715, 6782.762603308861, 6806.6256355900905, 6837.521373503807, 5898.380670029585, 5997.55018373615, 5998.70006499682, 6005.669688167192, 6011.428914253139, 4358.455193100863, 4364.367166760865, 4405.18504076734, 4416.867493975186, 4567.0, 4376.256036473744, 4444.888877778081, 4525.886852828706, 4616.630669546361, 4619.7690115493415], "value": 3944.2634007638526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.92602812310986, 302.3559817588538, 308.53719420868697, 310.88963417986616, 311.07145171662586, 4878.829240976566, 4926.162552366098, 4929.778159982796, 4961.925571116427, 4989.900201995958, 4807.687500312477, 4829.686070405422, 4911.968486617806, 4912.312276281324, 4914.852554423364, 3652.561692596892, 3786.3563194257044, 3791.3744232201793, 3841.1165431950667, 3861.61383861613, 3843.9039024024482, 3850.595687452819, 3852.268069066882, 3855.556610989744, 3864.9613503865025, 3800.6959443244473, 3804.0, 3812.1994381179984, 3818.2745278397156, 3824.7131465140087, 3626.8005259710835, 3665.688416484602, 3795.3168429682646, 3824.8852534424013, 3852.8651497197743, 3403.421418358885, 3405.1997780521556, 3409.590849098099, 3412.2426950120707, 3413.4367829308135, 4820.783064762059, 4823.3729615149805, 4827.975860120677, 4832.985073134646, 4854.393200849894, 4103.589641035873, 4332.761698106603, 4416.315471101984, 4422.491413487458, 4423.911521769546, 5090.236464530313, 5097.745112744385, 5128.845884728423, 5143.0, 5152.201408781645, 3630.945535816965, 3634.0, 3635.2366003139373, 3635.5455568053994, 3647.544056992876, 5086.54221120101, 5254.97372513135, 5349.197620356938, 5364.383095943977, 5380.381256155553, 3634.9276963295893, 3683.778973261613, 3690.2066055797595, 3699.9445008324897, 3710.387786015331, 3759.0, 3762.6425489578446, 3765.9643598010766, 3772.490713753663, 3776.206996530759, 4290.656747460196, 4309.913801723948, 4311.76285304305, 4313.482382114166, 4324.0919406924895, 4875.780589873464, 5084.491550844886, 5085.415177254663, 5132.743362831919, 5143.717095559706, 1282.160185078775, 1303.947842086325, 1305.8171855940177, 1318.2156616813172, 1319.195290872567, 780.3094261578544, 813.7029984055895, 817.3665409307715, 817.5871185051511, 823.5799742131436, 4455.0, 4527.796249168795, 4587.770611469413, 4594.379758732595, 4609.976950115228, 5291.1798671206025, 5299.920501192485, 5304.223085266479, 5305.0, 5343.812966546152, 4398.2962725964335, 4557.863264102082, 4560.977195114003, 4566.0, 4614.676972611885, 2770.016644091359, 2784.484870299001, 2787.1081253998527, 2789.800385834111, 2806.1581525542256, 4979.178435558092, 4987.825426110068, 5051.949480505222, 5056.898862022813, 5071.3153724247495, 5105.285260063594, 5310.203469479532, 5419.620626556182, 5430.13117901134, 5431.53831924283, 4956.306117143603, 5003.424606170337, 5006.774695138727, 5011.473795251446, 5023.6483446159145, 5301.946980530145, 5320.201969704575, 5326.786928522815, 5344.0, 5347.51872331492, 5027.446980832178, 5129.717865517432, 5170.457102004236, 5185.896282074413, 5186.196139598368, 4969.776360063734, 5056.797728090835, 5061.974690126526, 5063.316452278895, 5072.416672082758, 3716.6097559756918, 3749.2501499699624, 3766.1526156615637, 3766.8681596144, 3770.246835221635, 5186.325777648882, 5208.5312321891215, 5278.788848446019, 5343.171808369709, 5355.062863998707, 5064.898702026013, 5087.64386492942, 5180.119379705535, 5192.299039629753, 5203.141481655484, 5146.202338637517, 5177.404598471224, 5185.9222111669105, 5200.893638076585, 5203.531682148625, 4898.289747986593, 5020.113434774946, 5045.520675535819, 5081.18701007837, 5089.770960306869, 4908.312836202863, 4999.500049994971, 5090.618203634668, 5146.459621739664, 5160.922586161136, 5032.798688052437, 5035.018171456531, 5061.31672224245, 5088.720120393414, 5105.978804239093], "value": 3863.1997188861887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.673256639114, 665.8701553197128, 668.5320275806936, 671.6910221298205, 728.2971932085536, 11133.0, 12794.23234605923, 13479.0, 13889.7916531252, 13890.583282501528, 13944.651383715413, 14064.367103480343, 14741.778873316909, 14745.0, 14758.409663613442, 761.3072104384997, 772.9613519324039, 780.1379475679378, 780.6135962698472, 780.6292011294646, 629.1789215074326, 758.2531206761336, 775.1860546426229, 775.9689612415497, 776.1927595300908, 818.7543736878943, 826.3554427546493, 827.9710210142646, 828.5443006346516, 828.6271177969937, 822.4448497264383, 822.48183644304, 822.8354329134197, 822.8889099971547, 823.0082750285922, 597.8983572792636, 598.5660396212754, 598.7036416973626, 598.9281286245679, 598.9880202395972, 12976.156549824325, 13105.410256538478, 13319.334033298393, 13471.595852124452, 13553.0, 13316.400761965735, 13578.1853088814, 13760.93119534396, 13835.169889806542, 14080.577582672537, 9999.500024998793, 10137.847932280947, 10250.538725757358, 10358.274920755475, 10452.425116618582, 3304.603447586281, 3315.1546355679147, 3316.4196265653654, 3335.8999230023137, 3346.9832650836834, 66123.33876661268, 67249.32750672528, 68787.0, 70345.29654703439, 71225.2877471229, 10376.377417354983, 10529.36823790575, 10614.628488002883, 10657.73355666099, 10666.466676666136, 19579.902100489406, 19931.20275189005, 19946.30187943415, 19954.20183192685, 19992.50018749543, 6460.12788273577, 6908.101946746991, 6951.339622735832, 6958.304169583002, 7338.156112047183, 3736.4768932349493, 3800.3539398302355, 3822.827972741233, 3836.462895194675, 4007.959920400817, 2848.188266344082, 2934.383779406306, 3280.9343813123605, 3440.449528075496, 3469.774464659789, 551.3136145498879, 564.7656222667629, 566.2355819643449, 567.2993852592045, 569.4191924237255, 459.4188351735058, 482.69831355402874, 508.16914345046115, 512.2853619201194, 564.3594520219498, 7484.812879677943, 7844.37245020397, 7906.446548741533, 7981.600919953979, 8122.309603683635, 459.56341475598316, 462.81718721104977, 502.62052150626045, 528.899509093271, 561.7107189797258, 3538.203904121552, 3789.4694742736037, 3958.267720471722, 3976.324024915771, 4157.812898419578, 57436.0, 98178.50910745401, 100286.0, 102510.0, 103252.0, 67981.6600917002, 75739.62130189314, 79562.60218698869, 79913.0, 87683.0, 67232.6638366805, 69810.9528357075, 71019.64490177516, 73115.63442182861, 73472.26527734761, 7897.4076944230565, 8475.194856488624, 8626.0, 8770.561471926505, 8853.0, 31999.20011998219, 37122.44316335311, 44610.330845038, 44912.32631510595, 46008.53991460043, 38320.6167938317, 44986.10027799491, 60920.39079609147, 61681.38318616936, 61974.38025619686, 10463.476826158509, 10768.46157692128, 10771.0, 10920.071793897609, 11526.88473115258, 9997.800043999225, 11121.0, 13047.347632618521, 13315.600531983668, 14229.217393043482, 11409.144314176636, 11686.474108664961, 11696.70758231051, 12288.877111228774, 12828.230306181658, 10510.264281500222, 10544.736381590521, 10759.031687148194, 10862.728431789268, 11374.20380573352, 10928.562857485611, 11646.475908584303, 11647.6505704829, 11826.46780894879, 11855.822162667395, 10039.749006274902, 10197.898021019695, 10259.846102308322, 10298.279120461495, 10833.187510936554, 9441.669541566012, 9704.417734935927, 10150.847737284093, 10166.805380432745, 10270.435126068138], "value": 6514.199454615919, "unit": "score"}], "name": "dromaeo_css", "value": 6347.341275426403, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 115.0, 114.0, 111.0, 113.0, 114.0, 114.0, 115.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 129.0, 179.0, 123.0, 126.0, 152.0, 126.0, 181.0, 132.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 123.0, 78.0, 77.0, 76.0, 77.0, 126.0, 77.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 128.0, 86.0, 86.0, 86.0, 116.0, 86.0, 86.0, 120.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 63.0, 63.0, 66.0, 64.0, 63.0, 64.0, 69.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 82.0, 83.0, 84.0, 83.0, 89.0, 87.0, 82.0, 82.0, 82.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 145.0, 143.0, 130.0, 132.0, 134.0, 132.0, 131.0, 149.0, 135.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 184.0, 176.0, 171.0, 176.0, 172.0, 174.0, 173.0, 177.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 71.0, 68.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1553.5, "alertThreshold": 2.0}]} 16:32:54 INFO - Return code: 0 16:32:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:32:54 INFO - # TBPL SUCCESS # 16:32:54 INFO - Running post-action listener: _resource_record_post_action 16:32:54 INFO - [mozharness: 2016-08-15 23:32:54.132152Z] Finished run-tests step (success) 16:32:54 INFO - Running post-run listener: _resource_record_post_run 16:32:54 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403959808; Read time: 12; Write time: 576644 16:32:54 INFO - TinderboxPrint: CPU usage
13.0% 16:32:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:32:54 INFO - TinderboxPrint: I/O write bytes / time
403,959,808 / 576,644 16:32:54 INFO - TinderboxPrint: CPU idle
8,352.9 (87.0%) 16:32:54 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 16:32:54 INFO - TinderboxPrint: Swap in / out
0 / 0 16:32:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114008064; Read time: 0; Write time: 238060 16:32:54 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289951744; Read time: 12; Write time: 338584 16:32:54 INFO - Running post-run listener: _upload_blobber_files 16:32:54 INFO - Blob upload gear active. 16:32:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:32:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:56 INFO - (blobuploader) - INFO - Done attempting. 16:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:56 INFO - (blobuploader) - INFO - Done attempting. 16:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:00 INFO - (blobuploader) - INFO - Done attempting. 16:33:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:00 INFO - Return code: 0 16:33:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a08c79ad737df6a1a7357aaa074aefe23d919860ba10856e725e05b6218798b36e8e2b5769d5a3e1cddc6776d96db03357ed548d5557ffb7a470f5878937050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25724d8efa117e73012a235770cc46baae5a6b9abef914d65cf09dae16c582f3f7e1fb9da1245bd7265ee9bf3f0708e57aa043992bf558b2ff2f8609ebed409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b38522ad343171e443e874b0ad9194a6e0900977709838e5b805837389db7c945f124b4815fab9d84658b8eb6bf276b0a7d69c4294d15a4a719cb26fbcf69d2e"} 16:33:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:00 INFO - Contents: 16:33:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a08c79ad737df6a1a7357aaa074aefe23d919860ba10856e725e05b6218798b36e8e2b5769d5a3e1cddc6776d96db03357ed548d5557ffb7a470f5878937050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25724d8efa117e73012a235770cc46baae5a6b9abef914d65cf09dae16c582f3f7e1fb9da1245bd7265ee9bf3f0708e57aa043992bf558b2ff2f8609ebed409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b38522ad343171e443e874b0ad9194a6e0900977709838e5b805837389db7c945f124b4815fab9d84658b8eb6bf276b0a7d69c4294d15a4a719cb26fbcf69d2e"} 16:33:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:00 INFO - Copying logs to upload dir... 16:33:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.311994 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-15 16:33:00.702819) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:33:00.706816) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a08c79ad737df6a1a7357aaa074aefe23d919860ba10856e725e05b6218798b36e8e2b5769d5a3e1cddc6776d96db03357ed548d5557ffb7a470f5878937050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25724d8efa117e73012a235770cc46baae5a6b9abef914d65cf09dae16c582f3f7e1fb9da1245bd7265ee9bf3f0708e57aa043992bf558b2ff2f8609ebed409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b38522ad343171e443e874b0ad9194a6e0900977709838e5b805837389db7c945f124b4815fab9d84658b8eb6bf276b0a7d69c4294d15a4a719cb26fbcf69d2e"} build_url:https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/Us0yZLRnQ32vkfeng91N7w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a08c79ad737df6a1a7357aaa074aefe23d919860ba10856e725e05b6218798b36e8e2b5769d5a3e1cddc6776d96db03357ed548d5557ffb7a470f5878937050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25724d8efa117e73012a235770cc46baae5a6b9abef914d65cf09dae16c582f3f7e1fb9da1245bd7265ee9bf3f0708e57aa043992bf558b2ff2f8609ebed409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b38522ad343171e443e874b0ad9194a6e0900977709838e5b805837389db7c945f124b4815fab9d84658b8eb6bf276b0a7d69c4294d15a4a719cb26fbcf69d2e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:33:00.732953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:33:00.733304) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471302729.736765-1287437694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004297 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:33:00.817439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:33:00.817765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:33:00.818045) ========= ========= Total master_lag: 0.19 =========