builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1470345858.0 results: success (0) buildid: 20160804130521 builduid: fe157091ff344fce8b586660aacd0687 revision: c60886d5c003908affbe74e56a7c5b88021b4c6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.003862) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.004295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.004566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.050533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.050807) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 14:24:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-08-04 14:24:18 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133207 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.226327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.226669) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.278170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:18.278532) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c60886d5c003908affbe74e56a7c5b88021b4c6e --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 c60886d5c003908affbe74e56a7c5b88021b4c6e --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=8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 14:24:18,989 truncating revision to first 12 chars 2016-08-04 14:24:18,989 Setting DEBUG logging. 2016-08-04 14:24:18,989 attempt 1/10 2016-08-04 14:24:18,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c60886d5c003?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 14:24:19,427 unpacking tar archive at: fx-team-c60886d5c003/testing/mozharness/ program finished with exit code 0 elapsedTime=0.781052 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:19.073360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:19.073686) ========= script_repo_revision: c60886d5c003908affbe74e56a7c5b88021b4c6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:19.074079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:19.074356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 14:24:19.085762) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-04 14:24:19.086054) ========= /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=8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:24:19 INFO - MultiFileLogger online at 20160804 14:24:19 in /builds/slave/test 14:24:19 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 14:24:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:24:19 INFO - {'append_to_log': False, 14:24:19 INFO - 'base_work_dir': '/builds/slave/test', 14:24:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:24:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:24:19 INFO - 'branch': 'Fx-Team-Non-PGO', 14:24:19 INFO - 'buildbot_json_path': 'buildprops.json', 14:24:19 INFO - 'config_files': ('talos/linux_config.py',), 14:24:19 INFO - 'default_actions': ('clobber', 14:24:19 INFO - 'read-buildbot-config', 14:24:19 INFO - 'download-and-extract', 14:24:19 INFO - 'populate-webroot', 14:24:19 INFO - 'create-virtualenv', 14:24:19 INFO - 'install', 14:24:19 INFO - 'run-tests'), 14:24:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:24:19 INFO - 'download_minidump_stackwalk': True, 14:24:19 INFO - 'download_symbols': 'ondemand', 14:24:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:24:19 INFO - 'tooltool.py': '/tools/tooltool.py', 14:24:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:24:19 INFO - '/tools/misc-python/virtualenv.py')}, 14:24:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:24:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:24:19 INFO - 'installer_path': 'installer.exe', 14:24:19 INFO - 'log_level': 'info', 14:24:19 INFO - 'log_name': 'talos', 14:24:19 INFO - 'log_to_console': True, 14:24:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:24:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:24:19 INFO - 'opt_config_files': (), 14:24:19 INFO - 'pip_index': False, 14:24:19 INFO - 'sps_profile': False, 14:24:19 INFO - 'sps_profile_interval': 0, 14:24:19 INFO - 'suite': 'dromaeojs', 14:24:19 INFO - 'system_bits': '32', 14:24:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:24:19 INFO - 'title': 'talos-linux64-ix-001', 14:24:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:24:19 INFO - 'use_talos_json': True, 14:24:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:24:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:24:19 INFO - 'work_dir': 'build'} 14:24:19 INFO - [mozharness: 2016-08-04 21:24:19.893806Z] Running clobber step. 14:24:19 INFO - Running pre-action listener: _resource_record_pre_action 14:24:19 INFO - Running main action method: clobber 14:24:19 INFO - rmtree: /builds/slave/test/build 14:24:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:24:20 INFO - Running post-action listener: _resource_record_post_action 14:24:20 INFO - [mozharness: 2016-08-04 21:24:20.871339Z] Finished clobber step (success) 14:24:20 INFO - [mozharness: 2016-08-04 21:24:20.871438Z] Running read-buildbot-config step. 14:24:20 INFO - Running pre-action listener: _resource_record_pre_action 14:24:20 INFO - Running main action method: read_buildbot_config 14:24:20 INFO - Using buildbot properties: 14:24:20 INFO - { 14:24:20 INFO - "project": "", 14:24:20 INFO - "product": "firefox", 14:24:20 INFO - "script_repo_revision": "production", 14:24:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:24:20 INFO - "repository": "", 14:24:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:24:20 INFO - "buildid": "20160804130521", 14:24:20 INFO - "pgo_build": "False", 14:24:20 INFO - "basedir": "/builds/slave/test", 14:24:20 INFO - "buildnumber": 1852, 14:24:20 INFO - "slavename": "talos-linux64-ix-001", 14:24:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:24:20 INFO - "platform": "ubuntu64_hw", 14:24:20 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 14:24:20 INFO - "branch": "fx-team", 14:24:20 INFO - "repo_path": "integration/fx-team", 14:24:20 INFO - "revision": "c60886d5c003908affbe74e56a7c5b88021b4c6e", 14:24:20 INFO - "stage_platform": "linux64", 14:24:20 INFO - "builduid": "fe157091ff344fce8b586660aacd0687", 14:24:20 INFO - "slavebuilddir": "test" 14:24:20 INFO - } 14:24:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:24:20 INFO - Running post-action listener: _resource_record_post_action 14:24:20 INFO - [mozharness: 2016-08-04 21:24:20.873898Z] Finished read-buildbot-config step (success) 14:24:20 INFO - [mozharness: 2016-08-04 21:24:20.873987Z] Running download-and-extract step. 14:24:20 INFO - Running pre-action listener: _resource_record_pre_action 14:24:20 INFO - Running main action method: download_and_extract 14:24:20 INFO - mkdir: /builds/slave/test/build/tests 14:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:20 INFO - trying https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:24:20 INFO - Downloading https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:21 INFO - Downloaded 1361 bytes. 14:24:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:24:21 INFO - Using the following test package requirements: 14:24:21 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:24:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:24:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:24:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'jsshell-linux-x86_64.zip'], 14:24:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:24:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:24:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:24:21 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:24:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:24:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:24:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:24:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:24:21 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')]} 14:24:21 INFO - trying https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:24:21 INFO - Downloading https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:22 INFO - Downloaded 20249167 bytes. 14:24:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:24:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:24:23 INFO - Return code: 0 14:24:24 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 14:24:24 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')]} 14:24:24 INFO - trying https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:24:24 INFO - Downloading https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:25 INFO - Downloaded 20249167 bytes. 14:24:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:24:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:24:26 INFO - Return code: 0 14:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:26 INFO - trying https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:24:26 INFO - Downloading https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:27 INFO - Downloaded 14413723 bytes. 14:24:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:24:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:24:28 INFO - Return code: 0 14:24:28 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')]} 14:24:28 INFO - trying https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:24:28 INFO - Downloading https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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 14:24:33 INFO - Downloaded 55652077 bytes. 14:24:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:24:33 INFO - mkdir: /builds/slave/test/properties 14:24:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:33 INFO - Contents: 14:24:33 INFO - build_url:https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:24:34 INFO - Running post-action listener: _resource_record_post_action 14:24:34 INFO - Running post-action listener: set_extra_try_arguments 14:24:34 INFO - [mozharness: 2016-08-04 21:24:34.540638Z] Finished download-and-extract step (success) 14:24:34 INFO - [mozharness: 2016-08-04 21:24:34.540923Z] Running populate-webroot step. 14:24:34 INFO - Running pre-action listener: _resource_record_pre_action 14:24:34 INFO - Running main action method: populate_webroot 14:24:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:34 INFO - '--tppagecycles', 14:24:34 INFO - '7'], 14:24:34 INFO - 'tests': ['tsvgm']}}, 14:24:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['damp', 'tps']}, 14:24:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'tests': ['damp', 'tps']}, 14:24:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['dromaeo_dom']}, 14:24:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['basic_compositor_video']}, 14:24:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:24:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['a11yr', 14:24:34 INFO - 'ts_paint', 14:24:34 INFO - 'tpaint', 14:24:34 INFO - 'sessionrestore', 14:24:34 INFO - 'sessionrestore_no_auto_restore', 14:24:34 INFO - 'tabpaint']}, 14:24:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:34 INFO - 'ts_paint', 14:24:34 INFO - 'tpaint', 14:24:34 INFO - 'sessionrestore', 14:24:34 INFO - 'sessionrestore_no_auto_restore', 14:24:34 INFO - 'tabpaint']}, 14:24:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:24:34 INFO - 'ts_paint', 14:24:34 INFO - 'tpaint', 14:24:34 INFO - 'sessionrestore', 14:24:34 INFO - 'sessionrestore_no_auto_restore', 14:24:34 INFO - 'tabpaint']}, 14:24:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:24:34 INFO - 'ts_paint', 14:24:34 INFO - 'tpaint', 14:24:34 INFO - 'sessionrestore', 14:24:34 INFO - 'sessionrestore_no_auto_restore', 14:24:34 INFO - 'tabpaint']}, 14:24:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['a11yr', 14:24:34 INFO - 'ts_paint', 14:24:34 INFO - 'tpaint', 14:24:34 INFO - 'sessionrestore', 14:24:34 INFO - 'sessionrestore_no_auto_restore', 14:24:34 INFO - 'tabpaint']}, 14:24:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['a11yr', 14:24:34 INFO - 'ts_paint', 14:24:34 INFO - 'tpaint', 14:24:34 INFO - 'sessionrestore', 14:24:34 INFO - 'sessionrestore_no_auto_restore', 14:24:34 INFO - 'tabpaint']}, 14:24:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['tsvgx', 14:24:34 INFO - 'tsvgr_opacity', 14:24:34 INFO - 'tart', 14:24:34 INFO - 'tscrollx', 14:24:34 INFO - 'cart']}, 14:24:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:34 INFO - 'tsvgr_opacity', 14:24:34 INFO - 'tart', 14:24:34 INFO - 'tscrollx', 14:24:34 INFO - 'cart']}, 14:24:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'talos_options': ['--disable-e10s'], 14:24:34 INFO - 'tests': ['tp5o']}, 14:24:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'tests': ['tp5o']}, 14:24:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'talos_options': ['--disable-e10s', 14:24:34 INFO - '--xperf_path', 14:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:34 INFO - 'tests': ['tp5n']}, 14:24:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:34 INFO - 'talos_options': ['--xperf_path', 14:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:34 INFO - 'tests': ['tp5n']}}, 14:24:34 INFO - 'talos.zip': {'path': '', 14:24:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:34 INFO - Running post-action listener: _resource_record_post_action 14:24:34 INFO - [mozharness: 2016-08-04 21:24:34.562151Z] Finished populate-webroot step (success) 14:24:34 INFO - [mozharness: 2016-08-04 21:24:34.562239Z] Running create-virtualenv step. 14:24:34 INFO - Running pre-action listener: _resource_record_pre_action 14:24:34 INFO - Running main action method: create_virtualenv 14:24:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:34 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 14:24:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:34 INFO - Using real prefix '/usr' 14:24:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:37 INFO - Installing pip.................done. 14:24:37 INFO - Return code: 0 14:24:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:37 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:37 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 14:24:37 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 14:24:37 INFO - Using env: {'DISPLAY': ':0', 14:24:37 INFO - 'HOME': '/home/cltbld', 14:24:37 INFO - 'LANG': 'en_US.UTF-8', 14:24:37 INFO - 'LANGUAGE': 'en_US:en', 14:24:37 INFO - 'LOGNAME': 'cltbld', 14:24:37 INFO - 'MAIL': '/var/mail/cltbld', 14:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:37 INFO - 'MOZ_NO_REMOTE': '1', 14:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:37 INFO - 'NO_EM_RESTART': '1', 14:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:37 INFO - 'PWD': '/builds/slave/test', 14:24:37 INFO - 'SHELL': '/bin/bash', 14:24:37 INFO - 'SHLVL': '1', 14:24:37 INFO - 'TERM': 'linux', 14:24:37 INFO - 'TMOUT': '86400', 14:24:37 INFO - 'USER': 'cltbld', 14:24:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:37 INFO - '_': '/tools/buildbot/bin/python'} 14:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:37 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 14:24:37 INFO - Cleaning up... 14:24:37 INFO - Return code: 0 14:24:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:37 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:37 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 14:24:37 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 14:24:37 INFO - Using env: {'DISPLAY': ':0', 14:24:37 INFO - 'HOME': '/home/cltbld', 14:24:37 INFO - 'LANG': 'en_US.UTF-8', 14:24:37 INFO - 'LANGUAGE': 'en_US:en', 14:24:37 INFO - 'LOGNAME': 'cltbld', 14:24:37 INFO - 'MAIL': '/var/mail/cltbld', 14:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:37 INFO - 'MOZ_NO_REMOTE': '1', 14:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:37 INFO - 'NO_EM_RESTART': '1', 14:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:37 INFO - 'PWD': '/builds/slave/test', 14:24:37 INFO - 'SHELL': '/bin/bash', 14:24:37 INFO - 'SHLVL': '1', 14:24:37 INFO - 'TERM': 'linux', 14:24:37 INFO - 'TMOUT': '86400', 14:24:37 INFO - 'USER': 'cltbld', 14:24:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:37 INFO - '_': '/tools/buildbot/bin/python'} 14:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:37 INFO - Downloading/unpacking psutil>=3.1.1 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:39 INFO - Installing collected packages: psutil 14:24:39 INFO - Running setup.py install for psutil 14:24:39 INFO - building 'psutil._psutil_linux' extension 14:24:39 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 14:24:39 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 14:24:39 INFO - building 'psutil._psutil_posix' extension 14:24:39 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 14:24:39 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 14:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:40 INFO - Successfully installed psutil 14:24:40 INFO - Cleaning up... 14:24:40 INFO - Return code: 0 14:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:40 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')]} 14:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:40 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')]} 14:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:40 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:40 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 14:24:40 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 14:24:40 INFO - Using env: {'DISPLAY': ':0', 14:24:40 INFO - 'HOME': '/home/cltbld', 14:24:40 INFO - 'LANG': 'en_US.UTF-8', 14:24:40 INFO - 'LANGUAGE': 'en_US:en', 14:24:40 INFO - 'LOGNAME': 'cltbld', 14:24:40 INFO - 'MAIL': '/var/mail/cltbld', 14:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:40 INFO - 'MOZ_NO_REMOTE': '1', 14:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:40 INFO - 'NO_EM_RESTART': '1', 14:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:40 INFO - 'PWD': '/builds/slave/test', 14:24:40 INFO - 'SHELL': '/bin/bash', 14:24:40 INFO - 'SHLVL': '1', 14:24:40 INFO - 'TERM': 'linux', 14:24:40 INFO - 'TMOUT': '86400', 14:24:40 INFO - 'USER': 'cltbld', 14:24:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:40 INFO - '_': '/tools/buildbot/bin/python'} 14:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:42 INFO - Installing collected packages: mozsystemmonitor 14:24:42 INFO - Running setup.py install for mozsystemmonitor 14:24:42 INFO - Successfully installed mozsystemmonitor 14:24:42 INFO - Cleaning up... 14:24:42 INFO - Return code: 0 14:24:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:42 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:42 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 14:24:42 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 14:24:42 INFO - Using env: {'DISPLAY': ':0', 14:24:42 INFO - 'HOME': '/home/cltbld', 14:24:42 INFO - 'LANG': 'en_US.UTF-8', 14:24:42 INFO - 'LANGUAGE': 'en_US:en', 14:24:42 INFO - 'LOGNAME': 'cltbld', 14:24:42 INFO - 'MAIL': '/var/mail/cltbld', 14:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:42 INFO - 'MOZ_NO_REMOTE': '1', 14:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:42 INFO - 'NO_EM_RESTART': '1', 14:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:42 INFO - 'PWD': '/builds/slave/test', 14:24:42 INFO - 'SHELL': '/bin/bash', 14:24:42 INFO - 'SHLVL': '1', 14:24:42 INFO - 'TERM': 'linux', 14:24:42 INFO - 'TMOUT': '86400', 14:24:42 INFO - 'USER': 'cltbld', 14:24:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:42 INFO - '_': '/tools/buildbot/bin/python'} 14:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:42 INFO - Downloading/unpacking jsonschema==2.5.1 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:44 INFO - warning: no files found matching '*.txt' 14:24:44 INFO - no previously-included directories found matching 'build' 14:24:44 INFO - no previously-included directories found matching 'dist' 14:24:44 INFO - no previously-included directories found matching '.git*' 14:24:44 INFO - Installing collected packages: jsonschema, functools32 14:24:44 INFO - Running setup.py install for functools32 14:24:44 INFO - warning: no files found matching '*.txt' 14:24:44 INFO - no previously-included directories found matching 'build' 14:24:44 INFO - no previously-included directories found matching 'dist' 14:24:44 INFO - no previously-included directories found matching '.git*' 14:24:44 INFO - Successfully installed jsonschema functools32 14:24:44 INFO - Cleaning up... 14:24:45 INFO - Return code: 0 14:24:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24:45 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')]} 14:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:45 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')]} 14:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:45 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:45 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 14:24:45 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 14:24:45 INFO - Using env: {'DISPLAY': ':0', 14:24:45 INFO - 'HOME': '/home/cltbld', 14:24:45 INFO - 'LANG': 'en_US.UTF-8', 14:24:45 INFO - 'LANGUAGE': 'en_US:en', 14:24:45 INFO - 'LOGNAME': 'cltbld', 14:24:45 INFO - 'MAIL': '/var/mail/cltbld', 14:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:45 INFO - 'MOZ_NO_REMOTE': '1', 14:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:45 INFO - 'NO_EM_RESTART': '1', 14:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:45 INFO - 'PWD': '/builds/slave/test', 14:24:45 INFO - 'SHELL': '/bin/bash', 14:24:45 INFO - 'SHLVL': '1', 14:24:45 INFO - 'TERM': 'linux', 14:24:45 INFO - 'TMOUT': '86400', 14:24:45 INFO - 'USER': 'cltbld', 14:24:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:45 INFO - '_': '/tools/buildbot/bin/python'} 14:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:45 INFO - Cleaning up... 14:24:45 INFO - Return code: 0 14:24:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:45 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')]} 14:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:45 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')]} 14:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:45 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:45 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 14:24:45 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 14:24:45 INFO - Using env: {'DISPLAY': ':0', 14:24:45 INFO - 'HOME': '/home/cltbld', 14:24:45 INFO - 'LANG': 'en_US.UTF-8', 14:24:45 INFO - 'LANGUAGE': 'en_US:en', 14:24:45 INFO - 'LOGNAME': 'cltbld', 14:24:45 INFO - 'MAIL': '/var/mail/cltbld', 14:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:45 INFO - 'MOZ_NO_REMOTE': '1', 14:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:45 INFO - 'NO_EM_RESTART': '1', 14:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:45 INFO - 'PWD': '/builds/slave/test', 14:24:45 INFO - 'SHELL': '/bin/bash', 14:24:45 INFO - 'SHLVL': '1', 14:24:45 INFO - 'TERM': 'linux', 14:24:45 INFO - 'TMOUT': '86400', 14:24:45 INFO - 'USER': 'cltbld', 14:24:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:45 INFO - '_': '/tools/buildbot/bin/python'} 14:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:45 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 14:24:45 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 14:24:45 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 14:24:45 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 14:24:45 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 14:24:45 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 14:24:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:48 INFO - Downloading docopt-0.6.1.tar.gz 14:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:48 INFO - Running setup.py install for blobuploader 14:24:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:48 INFO - Running setup.py install for requests 14:24:48 INFO - Running setup.py install for docopt 14:24:48 INFO - Successfully installed blobuploader requests docopt 14:24:48 INFO - Cleaning up... 14:24:48 INFO - Return code: 0 14:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:48 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:48 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 14:24:48 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 14:24:48 INFO - Using env: {'DISPLAY': ':0', 14:24:48 INFO - 'HOME': '/home/cltbld', 14:24:48 INFO - 'LANG': 'en_US.UTF-8', 14:24:48 INFO - 'LANGUAGE': 'en_US:en', 14:24:48 INFO - 'LOGNAME': 'cltbld', 14:24:48 INFO - 'MAIL': '/var/mail/cltbld', 14:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:48 INFO - 'MOZ_NO_REMOTE': '1', 14:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:48 INFO - 'NO_EM_RESTART': '1', 14:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:48 INFO - 'PWD': '/builds/slave/test', 14:24:48 INFO - 'SHELL': '/bin/bash', 14:24:48 INFO - 'SHLVL': '1', 14:24:48 INFO - 'TERM': 'linux', 14:24:48 INFO - 'TMOUT': '86400', 14:24:48 INFO - 'USER': 'cltbld', 14:24:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:48 INFO - '_': '/tools/buildbot/bin/python'} 14:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:48 INFO - Running setup.py (path:/tmp/pip-8TiDs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:49 INFO - Running setup.py (path:/tmp/pip-Abc01q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:49 INFO - Running setup.py (path:/tmp/pip-yq60bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:49 INFO - Running setup.py (path:/tmp/pip-gfpmCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:49 INFO - Running setup.py (path:/tmp/pip-v2lRDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:49 INFO - Running setup.py (path:/tmp/pip-UAGTDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:49 INFO - Running setup.py (path:/tmp/pip-MkWpvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:49 INFO - Running setup.py (path:/tmp/pip-rjP69P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:49 INFO - Running setup.py (path:/tmp/pip-nYHUH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:49 INFO - Running setup.py (path:/tmp/pip-1Ua9Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:49 INFO - Running setup.py (path:/tmp/pip-xTC9SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:49 INFO - Running setup.py (path:/tmp/pip-EjLQBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:49 INFO - Running setup.py (path:/tmp/pip-1Z2LlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:49 INFO - Running setup.py (path:/tmp/pip-fDkn_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:49 INFO - Running setup.py (path:/tmp/pip-guJG6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:50 INFO - Running setup.py (path:/tmp/pip-iQ8ce0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:50 INFO - Running setup.py (path:/tmp/pip-Nezuqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:50 INFO - Running setup.py install for manifestparser 14:24:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Running setup.py install for mozcrash 14:24:50 INFO - Running setup.py install for mozdebug 14:24:50 INFO - Running setup.py install for mozdevice 14:24:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Running setup.py install for mozfile 14:24:50 INFO - Running setup.py install for mozhttpd 14:24:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Running setup.py install for mozinfo 14:24:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Running setup.py install for mozInstall 14:24:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozleak 14:24:51 INFO - Running setup.py install for mozlog 14:24:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for moznetwork 14:24:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozprocess 14:24:51 INFO - Running setup.py install for mozprofile 14:24:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozrunner 14:24:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozscreenshot 14:24:51 INFO - Running setup.py install for moztest 14:24:51 INFO - Running setup.py install for mozversion 14:24:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:51 INFO - Cleaning up... 14:24:52 INFO - Return code: 0 14:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:52 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:52 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 14:24:52 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 14:24:52 INFO - Using env: {'DISPLAY': ':0', 14:24:52 INFO - 'HOME': '/home/cltbld', 14:24:52 INFO - 'LANG': 'en_US.UTF-8', 14:24:52 INFO - 'LANGUAGE': 'en_US:en', 14:24:52 INFO - 'LOGNAME': 'cltbld', 14:24:52 INFO - 'MAIL': '/var/mail/cltbld', 14:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:52 INFO - 'MOZ_NO_REMOTE': '1', 14:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:52 INFO - 'NO_EM_RESTART': '1', 14:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:52 INFO - 'PWD': '/builds/slave/test', 14:24:52 INFO - 'SHELL': '/bin/bash', 14:24:52 INFO - 'SHLVL': '1', 14:24:52 INFO - 'TERM': 'linux', 14:24:52 INFO - 'TMOUT': '86400', 14:24:52 INFO - 'USER': 'cltbld', 14:24:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:52 INFO - '_': '/tools/buildbot/bin/python'} 14:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:52 INFO - Running setup.py (path:/tmp/pip-ioer9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:52 INFO - Running setup.py (path:/tmp/pip-yHNKqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:52 INFO - Running setup.py (path:/tmp/pip-6mHuZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:52 INFO - Running setup.py (path:/tmp/pip-9VWbpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:52 INFO - Running setup.py (path:/tmp/pip-EXYQ4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:52 INFO - Running setup.py (path:/tmp/pip-UnL_aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:52 INFO - Running setup.py (path:/tmp/pip-m8cLz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:52 INFO - Running setup.py (path:/tmp/pip-UaIz1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:52 INFO - Running setup.py (path:/tmp/pip-evT5Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:52 INFO - Running setup.py (path:/tmp/pip-bY_BNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:52 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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:52 INFO - Running setup.py (path:/tmp/pip-WdS2eL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:53 INFO - Running setup.py (path:/tmp/pip-2YOCuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:53 INFO - Running setup.py (path:/tmp/pip-lp90QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:53 INFO - Running setup.py (path:/tmp/pip-L_lotu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:53 INFO - Running setup.py (path:/tmp/pip-q35qPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:53 INFO - Running setup.py (path:/tmp/pip-acqs_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:53 INFO - Running setup.py (path:/tmp/pip-i1GVek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:53 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)) 14:24:53 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)) 14:24:53 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)) 14:24:53 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)) 14:24:53 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)) 14:24:53 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)) 14:24:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:53 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 14:24:53 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 14:24:53 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 14:24:53 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 14:24:53 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 14:24:53 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 14:24:55 INFO - Downloading blessings-1.6.tar.gz 14:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:55 INFO - Installing collected packages: blessings 14:24:55 INFO - Running setup.py install for blessings 14:24:55 INFO - Successfully installed blessings 14:24:55 INFO - Cleaning up... 14:24:55 INFO - Return code: 0 14:24:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:55 INFO - Reading from file tmpfile_stdout 14:24:55 INFO - Current package versions: 14:24:55 INFO - argparse == 1.2.1 14:24:55 INFO - blessings == 1.6 14:24:55 INFO - blobuploader == 1.2.4 14:24:55 INFO - docopt == 0.6.1 14:24:55 INFO - functools32 == 3.2.3-2 14:24:55 INFO - jsonschema == 2.5.1 14:24:55 INFO - manifestparser == 1.1 14:24:55 INFO - mozInstall == 1.12 14:24:55 INFO - mozcrash == 0.17 14:24:55 INFO - mozdebug == 0.1 14:24:55 INFO - mozdevice == 0.48 14:24:55 INFO - mozfile == 1.2 14:24:55 INFO - mozhttpd == 0.7 14:24:55 INFO - mozinfo == 0.9 14:24:55 INFO - mozleak == 0.1 14:24:55 INFO - mozlog == 3.3 14:24:55 INFO - moznetwork == 0.27 14:24:55 INFO - mozprocess == 0.23 14:24:55 INFO - mozprofile == 0.28 14:24:55 INFO - mozrunner == 6.12 14:24:55 INFO - mozscreenshot == 0.1 14:24:55 INFO - mozsystemmonitor == 0.3 14:24:55 INFO - moztest == 0.7 14:24:55 INFO - mozversion == 1.4 14:24:55 INFO - psutil == 3.1.1 14:24:55 INFO - requests == 1.2.3 14:24:55 INFO - wsgiref == 0.1.2 14:24:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:55 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 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:55 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 14:24:55 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 14:24:55 INFO - Using env: {'DISPLAY': ':0', 14:24:55 INFO - 'HOME': '/home/cltbld', 14:24:55 INFO - 'LANG': 'en_US.UTF-8', 14:24:55 INFO - 'LANGUAGE': 'en_US:en', 14:24:55 INFO - 'LOGNAME': 'cltbld', 14:24:55 INFO - 'MAIL': '/var/mail/cltbld', 14:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:55 INFO - 'MOZ_NO_REMOTE': '1', 14:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:55 INFO - 'NO_EM_RESTART': '1', 14:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:55 INFO - 'PWD': '/builds/slave/test', 14:24:55 INFO - 'SHELL': '/bin/bash', 14:24:55 INFO - 'SHLVL': '1', 14:24:55 INFO - 'TERM': 'linux', 14:24:55 INFO - 'TMOUT': '86400', 14:24:55 INFO - 'USER': 'cltbld', 14:24:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:55 INFO - '_': '/tools/buildbot/bin/python'} 14:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 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)) 14:24:56 INFO - Cleaning up... 14:24:56 INFO - Return code: 0 14:24:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', '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 14:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:24:56 INFO - Using env: {'DISPLAY': ':0', 14:24:56 INFO - 'HOME': '/home/cltbld', 14:24:56 INFO - 'LANG': 'en_US.UTF-8', 14:24:56 INFO - 'LANGUAGE': 'en_US:en', 14:24:56 INFO - 'LOGNAME': 'cltbld', 14:24:56 INFO - 'MAIL': '/var/mail/cltbld', 14:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:56 INFO - 'MOZ_NO_REMOTE': '1', 14:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:56 INFO - 'NO_EM_RESTART': '1', 14:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:56 INFO - 'PWD': '/builds/slave/test', 14:24:56 INFO - 'SHELL': '/bin/bash', 14:24:56 INFO - 'SHLVL': '1', 14:24:56 INFO - 'TERM': 'linux', 14:24:56 INFO - 'TMOUT': '86400', 14:24:56 INFO - 'USER': 'cltbld', 14:24:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:56 INFO - '_': '/tools/buildbot/bin/python'} 14:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:24:56 INFO - Cleaning up... 14:24:56 INFO - Return code: 0 14:24:56 INFO - Running post-action listener: _resource_record_post_action 14:24:56 INFO - Running post-action listener: _start_resource_monitoring 14:24:56 INFO - Starting resource monitoring. 14:24:56 INFO - [mozharness: 2016-08-04 21:24:56.277611Z] Finished create-virtualenv step (success) 14:24:56 INFO - [mozharness: 2016-08-04 21:24:56.278089Z] Running install step. 14:24:56 INFO - Running pre-action listener: _resource_record_pre_action 14:24:56 INFO - Running main action method: install 14:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:56 INFO - Reading from file tmpfile_stdout 14:24:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:56 INFO - Reading from file tmpfile_stdout 14:24:56 INFO - Output received: 14:24:56 INFO - Usage: mozinstall [options] installer 14:24:56 INFO - Options: 14:24:56 INFO - -h, --help show this help message and exit 14:24:56 INFO - -d DEST, --destination=DEST 14:24:56 INFO - Directory to install application into. [default: 14:24:56 INFO - "/builds/slave/test"] 14:24:56 INFO - --app=APP Application being installed. [default: firefox] 14:24:56 INFO - mkdir: /builds/slave/test/build/application 14:24:56 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'] 14:24:56 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 14:25:12 INFO - Reading from file tmpfile_stdout 14:25:12 INFO - Output received: 14:25:12 INFO - /builds/slave/test/build/application/firefox/firefox 14:25:12 INFO - Running post-action listener: _resource_record_post_action 14:25:12 INFO - [mozharness: 2016-08-04 21:25:12.609768Z] Finished install step (success) 14:25:12 INFO - [mozharness: 2016-08-04 21:25:12.610013Z] Running run-tests step. 14:25:12 INFO - Running pre-action listener: _resource_record_pre_action 14:25:12 INFO - Running main action method: run_tests 14:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:12 INFO - Python 2.7.3 14:25:12 INFO - Return code: 0 14:25:12 INFO - grabbing minidump binary from tooltool 14:25: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')]} 14:25:12 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 0x22c13b0>, '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 0x22c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:12 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 14:25:12 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 14:25:12 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 14:25:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:12 INFO - Return code: 0 14:25:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:25:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:25:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:12 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/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:25:12 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/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 14:25:12 INFO - Using env: {'DISPLAY': ':0', 14:25:12 INFO - 'HOME': '/home/cltbld', 14:25:12 INFO - 'LANG': 'en_US.UTF-8', 14:25:12 INFO - 'LANGUAGE': 'en_US:en', 14:25:12 INFO - 'LOGNAME': 'cltbld', 14:25:12 INFO - 'MAIL': '/var/mail/cltbld', 14:25:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:12 INFO - 'MOZ_NO_REMOTE': '1', 14:25:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:12 INFO - 'NO_EM_RESTART': '1', 14:25:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:12 INFO - 'PWD': '/builds/slave/test', 14:25:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:12 INFO - 'SHELL': '/bin/bash', 14:25:12 INFO - 'SHLVL': '1', 14:25:12 INFO - 'TERM': 'linux', 14:25:12 INFO - 'TMOUT': '86400', 14:25:12 INFO - 'USER': 'cltbld', 14:25:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114', 14:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:12 INFO - '_': '/tools/buildbot/bin/python'} 14:25:12 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/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:25:12 INFO - mozversion application_buildid: 20160804130521 14:25:12 INFO - mozversion application_changeset: c60886d5c003908affbe74e56a7c5b88021b4c6e 14:25:12 INFO - mozversion application_display_name: Nightly 14:25:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:12 INFO - mozversion application_name: Firefox 14:25:12 INFO - mozversion application_remotingname: firefox 14:25:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:25:12 INFO - mozversion application_vendor: Mozilla 14:25:12 INFO - mozversion application_version: 51.0a1 14:25:12 INFO - mozversion platform_buildid: 20160804130521 14:25:12 INFO - mozversion platform_changeset: c60886d5c003908affbe74e56a7c5b88021b4c6e 14:25:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:25:12 INFO - mozversion platform_version: 51.0a1 14:25:12 INFO - using testdate: 1470345912 14:25:12 INFO - actual date: 1470345912 14:25:12 INFO - starting webserver on 'localhost:60927' 14:25:12 INFO - SUITE-START | Running 2 tests 14:25:12 INFO - TEST-START | dromaeo_css 14:25:12 INFO - operating with platform_type : linux_ 14:25:12 INFO - Initialising browser for dromaeo_css test... 14:25:12 INFO - TEST-INFO | started process 24541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qOATH/profile http://localhost:60927/getInfo.html) 14:25:17 INFO - PROCESS | 24541 | __metrics Screen width/height:1600/1200 14:25:17 INFO - PROCESS | 24541 | colorDepth:24 14:25:17 INFO - PROCESS | 24541 | Browser inner width/height: 1024/697 14:25:17 INFO - PROCESS | 24541 | __metrics 14:25:18 INFO - PROCESS | 24541 | 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" 14:25:18 INFO - PROCESS | 24541 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:18 INFO - PROCESS | 24541 | console.error: PushService: 14:25:18 INFO - PROCESS | 24541 | stateChangeProcessEnqueue: Error transitioning state 14:25:18 INFO - PROCESS | 24541 | UnknownError 14:25:19 INFO - TEST-INFO | 24541: exit 0 14:25:19 INFO - Browser initialized. 14:25:19 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:19 INFO - TEST-INFO | started process 24619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qOATH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:31 INFO - PROCESS | 24619 | RSS: Main: 157614080 14:25:31 INFO - PROCESS | 24619 | 14:26:21 INFO - PROCESS | 24619 | 1470345981750 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] 14:28:34 INFO - PROCESS | 24619 | Cycle 1(1): loaded http://localhost:60927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60927/tests/dromaeo/cssquery-ext.html) 14:28:36 INFO - PROCESS | 24619 | RSS: Main: 281120768 14:28:36 INFO - PROCESS | 24619 | 14:31:38 INFO - PROCESS | 24619 | Cycle 1(1): loaded http://localhost:60927/tests/dromaeo/cssquery-ext.html (next: http://localhost:60927/tests/dromaeo/cssquery-jquery.html) 14:31:39 INFO - PROCESS | 24619 | RSS: Main: 251535360 14:31:39 INFO - PROCESS | 24619 | 14:34:41 INFO - PROCESS | 24619 | Cycle 1(1): loaded http://localhost:60927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60927/tests/dromaeo/cssquery-mootools.html) 14:34:42 INFO - PROCESS | 24619 | RSS: Main: 222687232 14:34:42 INFO - PROCESS | 24619 | 14:37:44 INFO - PROCESS | 24619 | Cycle 1(1): loaded http://localhost:60927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60927/tests/dromaeo/cssquery-prototype.html) 14:37:45 INFO - PROCESS | 24619 | RSS: Main: 188952576 14:37:45 INFO - PROCESS | 24619 | 14:40:48 INFO - PROCESS | 24619 | Cycle 1(1): loaded http://localhost:60927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60927/tests/dromaeo/cssquery-yui.html) 14:40:48 INFO - PROCESS | 24619 | RSS: Main: 189276160 14:40:48 INFO - PROCESS | 24619 | 14:43:51 INFO - PROCESS | 24619 | Cycle 1(1): loaded http://localhost:60927/tests/dromaeo/cssquery-yui.html (next: http://localhost:60927/tests/dromaeo/cssquery-dojo.html) 14:43:51 INFO - PROCESS | 24619 | RSS: Main: 282238976 14:43:51 INFO - PROCESS | 24619 | 14:43:51 INFO - PROCESS | 24619 | __start_tp_report 14:43:51 INFO - PROCESS | 24619 | _x_x_mozilla_page_load 14:43:51 INFO - PROCESS | 24619 | _x_x_mozilla_page_load_details 14:43:51 INFO - PROCESS | 24619 | |i|pagename|runs| 14:43:51 INFO - PROCESS | 24619 | |0;dojo.html;2602.375429896825;2604.0755531786203;2608.6087086936964;2626.38280004199;2645.8015648826345;4627.074585082988;4698.718076915387;4723.0553889222165;4732.313814496896;4732.787024583893;4637.350770892078;4738.265568836827;4774.689645173062;4779.689320194185;4798.952010479894;4353.25994580922;4385.144896745128;4412.24991751403;4412.40432541606;4420.86737397877;4392.363107349448;4435.201663700533;4459.576340247671;4471.150481408538;4520.457545094593;4462.709923854955;4502.459704835408;4516.39028731122;4526;4534;4308.763018034007;4349.565043495657;4358.259095953696;4425.977870110629;4482.170798402306;4271.060366719348;4304.945288404329;4344.391785150082;4359.04101097758;4376.540463251376;4659.324397962277;4691.7888695008805;4714.976425117852;4746.335513028179;4747.715137091785;5091.719955402451;5095.617828662865;5139.997700448414;5141.871453213662;5146.922796158024;4902.803887844482;5021.824236151754;5076.873078173076;5081.136206844845;5109.821156259513;4765.928511072371;4794.832180873653;4803.303520989437;4813.422389313305;4821.421429428421;5234.528892399702;5238.528532432099;5266.815661451831;5279.709615971158;5285.286486324374;4872.683275587146;4904.681195722266;4970.875728106754;4973.1297023020825;5037.647364684511;5062.645614807002;5067.5185857343495;5087.465816089331;5117.385913690381;5123.538881500608;5015.899682006339;5018.749062546858;5024.748762561931;5035.471275516092;5084.77118529667;4908.337374454474;4927.137750893579;5005.9749701251985;5013.473585273494;5055.873603159876;4339.869803905888;4345.891352716208;4346.195953748566;4350;4388;3791.9241615167543;3811.2568049230135;3819.25524522721;3821.140243445258;3832.770033797981;4248.086661367821;4329.15581461612;4364.890877728082;4365.607095361433;4429;5140.280360749498;5141.53726164647;5152.149895267239;5153.793848246103;5208.921866172011;4372.256716358227;4382.320740285261;4385.144896745168;4386.824527018947;4428.3136113901755;4465.151621191963;4595.885102872388;4606.447226332862;4624.098300831306;4703.082898834695;4811.08589368019;4822.276658501182;4830.565249127595;4839.782209800497;4883.340748998839;5140.845774626618;5158.38099428071;5158.8968220636125;5163.974180129076;5203.791848326025;4626.6530010250035;4700.882477938079;4743.312219728189;4750.334953106499;4820.035992801384;4978.352814134139;5005.374328208974;5008.298838162587;5011.098002359465;5049.899002020013;5035.16919708244;5078.873028174177;5081.949180508295;5083.87290317745;5133.589312855037;4787.305840653016;4885.780139893643;4893.681910675795;4927.310176575354;4985.102681517362;4928.852134435972;4939.75301234944;4941.135301322326;4948.257761335828;4994.850154495371;4882.877928051827;4894.608431325557;4952.207646776498;4957.801687932442;4964.602831773522;4834.854954351375;4889.90220195587;4896.020795840775;4915.5330243626795;4926.482719314564;4850.660453768202;4859.052484765437;4865.367502224688;4890.168671325812;4917.360743103373 14:43:51 INFO - PROCESS | 24619 | |1;ext.html;564.4891373307156;564.7882044233412;575.6948817126921;579.3829571506345;591.1015256809648;28064.438711225765;38573;40102.799486002565;40136.19727605453;43651.56348436515;39633.40549891754;40003;40020.59979400205;40032.59967400325;40130.197396052135;7464.813379665525;7593.468457207998;7602.353799926986;7604.0875094988405;7618.238176182393;7425.257474252586;9715.222782177409;9886.209103271722;9958.302918795687;10359.378437293786;10089.899101009007;10204.795904081951;10220;10225.23310751693;10230.386176829414;10016.449095299755;10078.697639070839;10098.040686134806;10099.242556808269;10106.140978016878;9940.552675129637;10017.649382271658;10021.398716076987;10027.047430494164;10037.598496060149;38716.22567548662;39113.413298800544;39128.41307380392;39168.41247381292;39255.60744392548;2878.3811480531576;3031.6058912341473;3140.450421176285;3188.171075520358;3612.060864175307;28739.71260287391;28774.42451150986;29078;29172;29776.553351699742;3473.9826300868335;3528.5065402467226;3533.646635336446;3564.82175891207;3615.0600843780544;262502;263573;263833;264424;264594;52110.47889521056;52338.21492677613;52381.7380913093;52400.73799630978;52488.212676809875;32147.67852321447;32896.1775955603;33002.66997330044;34808.651913481044;55058.72470637701;14965.102093874402;15181.392744290104;15233.162176080423;15237.695246095016;15247.085174889542;10319.638812641671;11180.217384782987;11397.943010284895;11456.026237769716;11466.2546934449;17209.311627535008;17716.557086072695;17850.732239016426;17891.821081789014;18104;6747.257801641816;6830.453563714891;6867;6977.372036516738;6977.616231107338;730.7332823519378;779.3142035009269;816.4856140631364;832.1054866018933;906.5829718329642;27537.724622753918;28601.28496787597;29359.706402936125;29369.7063029367;30618.54072188919;832.2676045080291;895.3240303570763;910.6767097680361;964.5514835601479;973.3721749471551;14165.291735413395;14984.100953942798;15083.095014299177;15190.544283671286;15297.923510382378;398598;402201;402705;403249;403255;47438;48091;48091.5190848087;48115.75942120337;48125;1070.9410982396043;1135.9261647992853;1153.4866984192122;1159.9246049006788;1166.3293606176483;26629.733702662725;27513.862430687717;27784.44431111326;28571.714282856905;28611.856940715163;41189;41854.79072604617;41912;41934.1613167741;41953;330381;333220;333935;334311;389091;38616.42075368816;38919.805400972815;39029.80485097556;39056;39669;42288.1542369157;42350.36474452824;42516.149677006906;42623.786881065396;43420.131597368505;36760;36833;37060.92329843769;37595.812020940815;38172;36521.634783651825;36952.44571331486;37132;37239.255214895005;37808.24383512369;35810.462843056855;36085;36536;36806.63193368139;37547.249055019296;31468.842655786575;32796.672033280316;33367.33265334728;33412.49881251735;33489.497657534666;25494.334426033674;25610.773388212223;25849.224523264333;25872.353191170372;26126.477470450864 14:43:51 INFO - PROCESS | 24619 | |2;jquery.html;333.3666034534386;348.97382696297785;358.40146954585833;364.50427418710547;382.36336499727935;12773.361331933402;16398.754018689713;17087.743683844754;17518;18696.81303186968;15148.621284467894;17307.82692173081;17588.120593970314;17616;17694.203760830762;4986.700797952134;5101.770420331075;5186.351706036746;5205.687658740469;5207.947920520804;3694.3719567673425;5159.793608255665;5237.188235823434;5783.5084017858535;6086.026235802273;6153.476954458876;6176.289726681444;6181.629102253857;6181.783637572686;6182.165407669952;5920.141579470974;6142.84642883927;6163.7842675506145;6170.444659980579;6182.443580077769;5205.947940520584;5400.459954004607;5405.162199859028;5408.4050754416985;5414.7834086636485;21066.683999740017;21278.787212127834;21378.144874205012;21397.144114235412;21413;1905.7427247321573;2065.8863762493056;2172.8587641803233;2312.1791763923734;2376.823472381165;12591.811122833165;13275.668108297274;13314.800277995837;13534;13714.382852771649;1708.6497268060018;1743.0935913325;1751.9386821461314;1803.9098045097692;1815.754873092129;44060;44506;65929.3407065928;70934.64532677355;71128.64435677789;9362.719118426457;9506.857397139049;9650.806983860424;9670.421943880809;10052.64815731446;13172.143810652276;13213.933930330288;13223.801642975362;13240;13285;7289.70841166358;7299.4525410594415;7501;7502.324790768857;7570.356519695888;7146.642667866586;7159.105111861018;7272.818179545554;7449.404047676173;7481.775546733498;5976.223090998143;6051.243594550681;6062;6131.6321020738005;6303.716332765037;1493.8580834820675;1679.9328026878788;1692.4161164398263;1697.125980120239;1705.9573510662085;716.7276434954683;828.2007862412801;850.9319254459629;930.9991758859253;977.296346630425;16527.752083718755;17054.829451705573;17722.379716709853;17823.554411139827;17936.55158621019;820.3150369441464;823.1192623892497;850.4599579267086;864.1919804982361;912.1653686876566;9626.66306679277;9693.22454203662;10503.52734126966;10532.578696852193;10654.360738355723;438822;441961;451413;451852;455961;84993;89298.55350723334;89912;90078;90630;903.6114470777497;933.0436302789559;963.4797209506788;966.5602151021268;967.6564819489121;15829.960519454997;16017.679646406774;16077.919610401874;16777.412790552273;17012.914935425244;40883.18233635251;40996.18007639771;41066.1786764269;41169.58830411657;41860.79069604632;53383;54305.72847135739;55541.1668824976;55591.166132507235;57189.42810571841;7439.62801859894;7494.887576686463;7523.022007139037;7618.162002179866;7964.084130325086;10456.68629941103;11322.26405283654;11327.660170194908;11491.597794077166;11968.700782480508;9734.221262299141;9946.651867184613;10020.949895250476;10022.24833137503;10810.837837432287;10162.39025658463;10167.796644067224;10249.38503689781;10380.221483388625;10629.787404252027;10413.635522756667;10442.895571044191;10561.63034293796;11019.724506887393;11039.503222354853;7494.962525187339;7537.472376933562;7584.734534291273;7623.809404764704;7699.499532530368;9052.637894484147;10240.590376384862;10266.178705703674;10499.222371840275;10654.200934929757 14:43:51 INFO - PROCESS | 24619 | |3;mootools.html;1341.483528841396;1375.2848518770238;1425.5794540610518;1593.7290660587698;1647.6210471591535;6747.359000894913;7274.308940650643;7290.161631412389;7297.70809167634;7303.269673032701;6135.8772824543485;6316.242050953881;6802.523823332356;7070.5404148730295;7168.319009694071;2093.424308315214;2116.47088227943;2120.628889944261;2120.968185477219;2124.0654112190587;2041.7665590140907;2064.917403303866;2151.34384012876;2154.504463973287;2156.2345367394582;1762.0661049643709;2002.429307647321;2105.757837848652;2107.757607875091;2112.8415368847322;2101.0125241136643;2107.7892210778878;2122.755883073451;2129.0525716056363;2130.9999999999923;2064.1227478321653;2065.2565076572423;2066.669332906743;2069.079259729421;2069.182672844218;7168.856622867514;7172.426205903515;7208.891866622005;7210.098737657793;7215.494915355927;4171;4291.291936830419;4298;4309.030468144674;4312.5903039211225;2731.7814574833965;2828.1091456191234;2829.915102546927;2835.3620435402077;2843.3033906692785;842.7935155886786;898.0166717444388;914.5153068873508;920.2270093121743;924.9815003699888;9346.485943273117;9427.198688111519;9427.622895084189;9429.481378524179;9438.244940404751;3676.7977761223387;3812.6568608825337;3905.668018218483;3963.8216280267457;3968.761874287552;8137.430379873471;8138.674453021813;8139.674413023531;8142.145074767182;8148.755537333889;4300.913981720348;4308.89227769302;4314.029343397773;4317.611414972667;4318.222719910446;3977.2443235785686;3994.2410941920944;3994.800259986989;4003.959960400417;4007.138465229931;3145.465270903952;3280.048785852076;3292.1111299949357;3344.0970937846646;3358.596968363812;963.7735132243918;974.1378879691382;975.1029053271008;977.7408986618552;984.8621193032981;586.7195242814668;620.3393386043849;671.1543455246425;736.4807810493589;750.3471979377977;4969.18008528596;5024.221245706921;5050.974745126251;5061.038402703474;5202.97398513005;840.5923127283263;866.913308669128;875.7066382761719;877.0615441477557;881.7310720230263;3335.5830521184853;3433.2790114075824;3462.1690794209208;3471.9826400867832;3550.786952782841;8314.459560128573;8591.183837535424;8652.221300082896;8658.523781191969;8682.34882383811;7962.124166341698;8237.135100814328;8291.419600628018;8497.830043399097;8670.696525621574;6537.215534135934;6701.128853249046;6724.361185687352;6724.66376681164;6729.05793188954;4957.628177886745;4963.10664080469;5051.343325367826;5180.404253510744;5251.684898906078;7709.537427754352;8008.15914328987;8034;8084.797880053045;8125.79685507867;8064.193580641889;8221.917780822354;8260.256576908107;8318.667253309799;8378.329733621174;6178.320384757583;6232.626042437469;6268.623882567061;6279.277883043508;6378.617282963037;6611.768588099393;6713.865722685617;6723.361280678328;6734.225564060196;6748;6096.085587161784;6165.260168779596;6291.1192433058495;6419.486441084796;6427.421532062137;6230.937690623035;6241.21984751906;6270.372962703876;6271.905921411274;6319;5829.417058294137;6002.729877155626;6022.488088512526;6030.3668114847305;6032.366601506778;4072.490938632671;4136.276151673505;4209.515905670887;4222.071144348239;4251.723637963522;4172.666186705117;4180.143070670444;4233;4292.484901811803;4317.740935543878 14:43:51 INFO - PROCESS | 24619 | |4;prototype.html;282.920534074552;289.70305436927146;292.247462783333;293.8662908376689;294.28341987261024;4810.567048965592;4867.075255701423;4872.780724867381;4894.2413925841465;4923.015396920617;4803.703000189947;4806.5193480651915;4831.661783675144;4831.767899185712;4841.782119804609;3606.1886075632906;3659.597444281127;3726.3106325329763;3763.849446022156;3845.9038524036914;3761.322961866863;3763.1909139534996;3777.1690228149764;3779.489768881207;3789.810509474529;3737.2338670572603;3740.4202348635868;3752.5496940367193;3753.7935413552245;3769.8115094245313;3610.8375123119654;3676.5588129424373;3756.906077348061;3789;3794.430835374716;3346.263821959165;3346.498025296201;3349.6315405305395;3363.5795525559306;3371.157210697326;4734.786934587917;4746.4541577718655;4757.952420475785;4759.762011899391;4769.379980602499;4194.91610167798;4354.412154359153;4354.517924782875;4363.47638283408;4366.969359247965;5008.198688209869;5046.7224302663335;5051.494850514919;5061.266116413136;5065.316182315377;3656.707463402948;3657.6159503252306;3662.1943172502006;3667.8716244931566;3684.0237337105686;5069.340985671876;5267.683938963636;5282.709450980195;5290.259363689087;5294.894102117974;3752.7185461090526;3758.248350329945;3762.6613604775703;3767.3628460077507;3772.1889793694486;3811.1805961718364;3812.5615554211067;3813.0848596336677;3824.6613685209954;3824.9808750956067;4302.849400270976;4323.027318853233;4328.718633288826;4337.91552111972;4352.825886964486;4783.182390691515;5013.172826483589;5013.3983921928875;5022.347094877716;5057.772400241998;1303.1855090568395;1323.9404226809816;1323.9735205296033;1326.9601911942657;1334.3395019465427;812.6099472253352;837.8282452097305;851.7096598653046;853.9829203416022;856.8072183758604;4280.186764514732;4361.149575832682;4486.506484286726;4487.977560112178;4495.9325610115875;5148.613853960968;5200.60995425337;5215.634905556574;5223.190405487156;5229.816956406507;4462.642988560908;4468.084042771224;4472.485664148665;4479.178117785839;4499.6400287976885;2624.934376640561;2759.503289407886;2773.571610620532;2778.3748656552116;2781.4715204111153;4900.240462728283;4903.362562866876;4907.460179380265;4921.458639549646;4925.458199598042;5116.692998420107;5346.732663366894;5358.892822143535;5370.167624018283;5378.51593356592;4841.201201801663;4903.901921961469;4907.411110666671;4909.435414927258;4917.262410638433;5210.47895210476;5215.791368345223;5222.8955420892125;5247.609383513448;5257.789688412574;4983.925241121314;5118.948810511996;5128.538431541179;5135.666181698178;5158.226266060121;4885.65800393969;4906.926396104132;4938.38270216223;4948.851534453972;4955.454899961073;3731.589525152177;3732.07797984033;3737.6075512070843;3743.326201283795;3760.8307626157434;5035.345405097314;5259.658122222043;5262.131748261494;5273.920891186712;5275.683458992473;5030.974845125751;5057.7724002419245;5065.493450654905;5066.214736715815;5085;5054.8769516802295;5059.924101138559;5060.342155519759;5074.898502030012;5095.490450954875;4871.732054736882;4926.926096108489;4957.900841983068;4984.277279794482;5031.7484125792835;4858.514148585255;4988.950110498994;5049.091163590589;5105.412877518985;5113.667611605234;4820.276958456259;4884.413870335582;4890.682105663121;4891.87770305731;4906.190478570996 14:43:52 INFO - PROCESS | 24619 | |5;yui.html;623.3174673732263;637.8532937424395;638.9488840892732;708.2351060854278;753.175273075982;12935.2238865668;13758.449662013532;14101.647458813535;14124.011319207646;14129.858701412983;13563.52527661532;13640.18158910466;13655.863441365584;13672.111312764688;13693.520726774565;764.7361660227226;793.8015496125969;796.3509739562268;798.1260519730886;798.3413683710933;640.7340953504313;758.8140905478166;793.9444238903279;797.5493845977004;797.6131576185545;825.9174082591753;827.8385714785619;827.8799574061758;832.7127141136298;833.8749187621845;829.0300348592161;829.6225217526011;829.8298848736055;829.9087100418949;830.6967956695793;494.5721950512781;502.18395107949584;503.3908970146091;506.37209859773617;583.067092651758;12791.360431978457;13291.468341266338;13302.401391937387;13309.267990260532;13332.866671333357;12539.686507837287;12561.795284083613;12901.419436125398;12932;12986.350682465933;11792.127671181286;11933.641990740205;11995.28028318295;12143.089268304824;12859.421326040258;4197.957456077387;4246.447961764981;4253.6809739269365;4293.119910418357;4391.934120988188;67559;68064.3193568063;68411.315886841;68556.6572167141;68625.31374686239;10308;10376.325538839952;10391.324563903323;10785;11057.668269951915;18926;19178.52053698641;19253.518662033282;19267.51831204231;19402;6577.079208910756;6658.500612454085;6703.698333574904;6827.931720682829;7026.648667566601;3790.2419516096893;3797.525309336333;3800.5059342285326;3800.6959443244473;3817.866374676873;2782.638257026614;2858.0996985949773;2877.9712202878122;2878.553824157259;2880.5391137418333;466.10275220200975;477.54394553202303;484.97817598208167;486.14195944158587;490.825756856318;480.17889409110813;481;546.8878879829625;575.4849409778309;585.0843430031987;7462.96268518654;7552.39580833532;7990.960045199737;8141.1275406656805;8185.099639039701;518.5488624896288;553.6456667732655;556.9164625306155;564.6950646650845;601.8465291350677;3521.506989021539;3618.4029635110437;3848.5189351331082;3850.133719912997;3976.8608098716404;93106;94454.52772736092;95790.52104739432;97102.51448742852;98032;78457;80062;81797.59101204576;83255.16744832596;85054.57472712721;70261;70742.64628676824;75301.11747206363;76468.61765691136;78060;7127.643617818984;7227.927720722725;7230.9638451807405;7272.96363518179;7524.849503010018;41065.178696425304;42282.78858605687;42335.7883210582;42492.362614561425;43057.354139687304;53491;54372.456275436736;58946.410535894094;61929.38070619416;64963.67518162379;9163.129502697233;9367.250619950251;9529.761755956157;9537.952310238681;9781.070798274437;11493.712657183638;11607.245529040585;11826.645200643994;12296.508139674313;12312.938435307766;10442.947785261025;10506.159507239556;10677.412742299248;10845.837312440162;10924.890751092706;10027.49862506857;10059.798804023732;10278.383297002203;10282.897171028193;10724.517396717323;9842.163416109424;9979.401235925867;9984.950075249577;10054.044865737744;10354.585816567253;8980.281577473917;9136.451812891248;9300.534973251446;9346.672866449642;9662.951685241529;8456.492610443393;8704.303655707401;8740.388172827841;8755.387122901591;8917.821643566962 14:43:52 INFO - PROCESS | 24619 | __end_tp_report 14:43:52 INFO - PROCESS | 24619 | __start_cc_report 14:43:52 INFO - PROCESS | 24619 | _x_x_mozilla_cycle_collect,1239 14:43:52 INFO - PROCESS | 24619 | __end_cc_report 14:43:52 INFO - PROCESS | 24619 | __startTimestamp1470347031986__endTimestamp 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - PROCESS | 24619 | ------- Summary: start ------- 14:43:52 INFO - PROCESS | 24619 | Number of tests: 6 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - PROCESS | 24619 | [#0] dojo.html Cycles:165 Average:4702.27 Median:4822.28 stddev:490.44 (10.2%) stddev-sans-first:463.45 14:43:52 INFO - PROCESS | 24619 | Values: 2602.4 2604.1 2608.6 2626.4 2645.8 4627.1 4698.7 4723.1 4732.3 4732.8 4637.4 4738.3 4774.7 4779.7 4799.0 4353.3 4385.1 4412.2 4412.4 4420.9 4392.4 4435.2 4459.6 4471.2 4520.5 4462.7 4502.5 4516.4 4526.0 4534.0 4308.8 4349.6 4358.3 4426.0 4482.2 4271.1 4304.9 4344.4 4359.0 4376.5 4659.3 4691.8 4715.0 4746.3 4747.7 5091.7 5095.6 5140.0 5141.9 5146.9 4902.8 5021.8 5076.9 5081.1 5109.8 4765.9 4794.8 4803.3 4813.4 4821.4 5234.5 5238.5 5266.8 5279.7 5285.3 4872.7 4904.7 4970.9 4973.1 5037.6 5062.6 5067.5 5087.5 5117.4 5123.5 5015.9 5018.7 5024.7 5035.5 5084.8 4908.3 4927.1 5006.0 5013.5 5055.9 4339.9 4345.9 4346.2 4350.0 4388.0 3791.9 3811.3 3819.3 3821.1 3832.8 4248.1 4329.2 4364.9 4365.6 4429.0 5140.3 5141.5 5152.1 5153.8 5208.9 4372.3 4382.3 4385.1 4386.8 4428.3 4465.2 4595.9 4606.4 4624.1 4703.1 4811.1 4822.3 4830.6 4839.8 4883.3 5140.8 5158.4 5158.9 5164.0 5203.8 4626.7 4700.9 4743.3 4750.3 4820.0 4978.4 5005.4 5008.3 5011.1 5049.9 5035.2 5078.9 5081.9 5083.9 5133.6 4787.3 4885.8 4893.7 4927.3 4985.1 4928.9 4939.8 4941.1 4948.3 4994.9 4882.9 4894.6 4952.2 4957.8 4964.6 4834.9 4889.9 4896.0 4915.5 4926.5 4850.7 4859.1 4865.4 4890.2 4917.4 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - PROCESS | 24619 | [#1] ext.html Cycles:180 Average:49099.47 Median:20068.35 stddev:89901.30 (448.0%) stddev-sans-first:90079.64 14:43:52 INFO - PROCESS | 24619 | Values: 564.5 564.8 575.7 579.4 591.1 28064.4 38573.0 40102.8 40136.2 43651.6 39633.4 40003.0 40020.6 40032.6 40130.2 7464.8 7593.5 7602.4 7604.1 7618.2 7425.3 9715.2 9886.2 9958.3 10359.4 10089.9 10204.8 10220.0 10225.2 10230.4 10016.4 10078.7 10098.0 10099.2 10106.1 9940.6 10017.6 10021.4 10027.0 10037.6 38716.2 39113.4 39128.4 39168.4 39255.6 2878.4 3031.6 3140.5 3188.2 3612.1 28739.7 28774.4 29078.0 29172.0 29776.6 3474.0 3528.5 3533.6 3564.8 3615.1 262502.0 263573.0 263833.0 264424.0 264594.0 52110.5 52338.2 52381.7 52400.7 52488.2 32147.7 32896.2 33002.7 34808.7 55058.7 14965.1 15181.4 15233.2 15237.7 15247.1 10319.6 11180.2 11397.9 11456.0 11466.3 17209.3 17716.6 17850.7 17891.8 18104.0 6747.3 6830.5 6867.0 6977.4 6977.6 730.7 779.3 816.5 832.1 906.6 27537.7 28601.3 29359.7 29369.7 30618.5 832.3 895.3 910.7 964.6 973.4 14165.3 14984.1 15083.1 15190.5 15297.9 398598.0 402201.0 402705.0 403249.0 403255.0 47438.0 48091.0 48091.5 48115.8 48125.0 1070.9 1135.9 1153.5 1159.9 1166.3 26629.7 27513.9 27784.4 28571.7 28611.9 41189.0 41854.8 41912.0 41934.2 41953.0 330381.0 333220.0 333935.0 334311.0 389091.0 38616.4 38919.8 39029.8 39056.0 39669.0 42288.2 42350.4 42516.1 42623.8 43420.1 36760.0 36833.0 37060.9 37595.8 38172.0 36521.6 36952.4 37132.0 37239.3 37808.2 35810.5 36085.0 36536.0 36806.6 37547.2 31468.8 32796.7 33367.3 33412.5 33489.5 25494.3 25610.8 25849.2 25872.4 26126.5 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - PROCESS | 24619 | [#2] jquery.html Cycles:180 Average:26469.17 Median:247959.50 stddev:73802.44 (29.8%) stddev-sans-first:73983.38 14:43:52 INFO - PROCESS | 24619 | Values: 333.4 349.0 358.4 364.5 382.4 12773.4 16398.8 17087.7 17518.0 18696.8 15148.6 17307.8 17588.1 17616.0 17694.2 4986.7 5101.8 5186.4 5205.7 5207.9 3694.4 5159.8 5237.2 5783.5 6086.0 6153.5 6176.3 6181.6 6181.8 6182.2 5920.1 6142.8 6163.8 6170.4 6182.4 5205.9 5400.5 5405.2 5408.4 5414.8 21066.7 21278.8 21378.1 21397.1 21413.0 1905.7 2065.9 2172.9 2312.2 2376.8 12591.8 13275.7 13314.8 13534.0 13714.4 1708.6 1743.1 1751.9 1803.9 1815.8 44060.0 44506.0 65929.3 70934.6 71128.6 9362.7 9506.9 9650.8 9670.4 10052.6 13172.1 13213.9 13223.8 13240.0 13285.0 7289.7 7299.5 7501.0 7502.3 7570.4 7146.6 7159.1 7272.8 7449.4 7481.8 5976.2 6051.2 6062.0 6131.6 6303.7 1493.9 1679.9 1692.4 1697.1 1706.0 716.7 828.2 850.9 931.0 977.3 16527.8 17054.8 17722.4 17823.6 17936.6 820.3 823.1 850.5 864.2 912.2 9626.7 9693.2 10503.5 10532.6 10654.4 438822.0 441961.0 451413.0 451852.0 455961.0 84993.0 89298.6 89912.0 90078.0 90630.0 903.6 933.0 963.5 966.6 967.7 15830.0 16017.7 16077.9 16777.4 17012.9 40883.2 40996.2 41066.2 41169.6 41860.8 53383.0 54305.7 55541.2 55591.2 57189.4 7439.6 7494.9 7523.0 7618.2 7964.1 10456.7 11322.3 11327.7 11491.6 11968.7 9734.2 9946.7 10020.9 10022.2 10810.8 10162.4 10167.8 10249.4 10380.2 10629.8 10413.6 10442.9 10561.6 11019.7 11039.5 7495.0 7537.5 7584.7 7623.8 7699.5 9052.6 10240.6 10266.2 10499.2 10654.2 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - PROCESS | 24619 | [#3] mootools.html Cycles:180 Average:4718.19 Median:6064.23 stddev:2549.78 (42.0%) stddev-sans-first:2544.31 14:43:52 INFO - PROCESS | 24619 | Values: 1341.5 1375.3 1425.6 1593.7 1647.6 6747.4 7274.3 7290.2 7297.7 7303.3 6135.9 6316.2 6802.5 7070.5 7168.3 2093.4 2116.5 2120.6 2121.0 2124.1 2041.8 2064.9 2151.3 2154.5 2156.2 1762.1 2002.4 2105.8 2107.8 2112.8 2101.0 2107.8 2122.8 2129.1 2131.0 2064.1 2065.3 2066.7 2069.1 2069.2 7168.9 7172.4 7208.9 7210.1 7215.5 4171.0 4291.3 4298.0 4309.0 4312.6 2731.8 2828.1 2829.9 2835.4 2843.3 842.8 898.0 914.5 920.2 925.0 9346.5 9427.2 9427.6 9429.5 9438.2 3676.8 3812.7 3905.7 3963.8 3968.8 8137.4 8138.7 8139.7 8142.1 8148.8 4300.9 4308.9 4314.0 4317.6 4318.2 3977.2 3994.2 3994.8 4004.0 4007.1 3145.5 3280.0 3292.1 3344.1 3358.6 963.8 974.1 975.1 977.7 984.9 586.7 620.3 671.2 736.5 750.3 4969.2 5024.2 5051.0 5061.0 5203.0 840.6 866.9 875.7 877.1 881.7 3335.6 3433.3 3462.2 3472.0 3550.8 8314.5 8591.2 8652.2 8658.5 8682.3 7962.1 8237.1 8291.4 8497.8 8670.7 6537.2 6701.1 6724.4 6724.7 6729.1 4957.6 4963.1 5051.3 5180.4 5251.7 7709.5 8008.2 8034.0 8084.8 8125.8 8064.2 8221.9 8260.3 8318.7 8378.3 6178.3 6232.6 6268.6 6279.3 6378.6 6611.8 6713.9 6723.4 6734.2 6748.0 6096.1 6165.3 6291.1 6419.5 6427.4 6230.9 6241.2 6270.4 6271.9 6319.0 5829.4 6002.7 6022.5 6030.4 6032.4 4072.5 4136.3 4209.5 4222.1 4251.7 4172.7 4180.1 4233.0 4292.5 4317.7 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - PROCESS | 24619 | [#4] prototype.html Cycles:180 Average:4210.52 Median:4831.71 stddev:1217.13 (25.2%) stddev-sans-first:1184.31 14:43:52 INFO - PROCESS | 24619 | Values: 282.9 289.7 292.2 293.9 294.3 4810.6 4867.1 4872.8 4894.2 4923.0 4803.7 4806.5 4831.7 4831.8 4841.8 3606.2 3659.6 3726.3 3763.8 3845.9 3761.3 3763.2 3777.2 3779.5 3789.8 3737.2 3740.4 3752.5 3753.8 3769.8 3610.8 3676.6 3756.9 3789.0 3794.4 3346.3 3346.5 3349.6 3363.6 3371.2 4734.8 4746.5 4758.0 4759.8 4769.4 4194.9 4354.4 4354.5 4363.5 4367.0 5008.2 5046.7 5051.5 5061.3 5065.3 3656.7 3657.6 3662.2 3667.9 3684.0 5069.3 5267.7 5282.7 5290.3 5294.9 3752.7 3758.2 3762.7 3767.4 3772.2 3811.2 3812.6 3813.1 3824.7 3825.0 4302.8 4323.0 4328.7 4337.9 4352.8 4783.2 5013.2 5013.4 5022.3 5057.8 1303.2 1323.9 1324.0 1327.0 1334.3 812.6 837.8 851.7 854.0 856.8 4280.2 4361.1 4486.5 4488.0 4495.9 5148.6 5200.6 5215.6 5223.2 5229.8 4462.6 4468.1 4472.5 4479.2 4499.6 2624.9 2759.5 2773.6 2778.4 2781.5 4900.2 4903.4 4907.5 4921.5 4925.5 5116.7 5346.7 5358.9 5370.2 5378.5 4841.2 4903.9 4907.4 4909.4 4917.3 5210.5 5215.8 5222.9 5247.6 5257.8 4983.9 5118.9 5128.5 5135.7 5158.2 4885.7 4906.9 4938.4 4948.9 4955.5 3731.6 3732.1 3737.6 3743.3 3760.8 5035.3 5259.7 5262.1 5273.9 5275.7 5031.0 5057.8 5065.5 5066.2 5085.0 5054.9 5059.9 5060.3 5074.9 5095.5 4871.7 4926.9 4957.9 4984.3 5031.7 4858.5 4989.0 5049.1 5105.4 5113.7 4820.3 4884.4 4890.7 4891.9 4906.2 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - PROCESS | 24619 | [#5] yui.html Cycles:180 Average:17476.37 Median:27459.67 stddev:25098.04 (91.4%) stddev-sans-first:25136.54 14:43:52 INFO - PROCESS | 24619 | Values: 623.3 637.9 638.9 708.2 753.2 12935.2 13758.4 14101.6 14124.0 14129.9 13563.5 13640.2 13655.9 13672.1 13693.5 764.7 793.8 796.4 798.1 798.3 640.7 758.8 793.9 797.5 797.6 825.9 827.8 827.9 832.7 833.9 829.0 829.6 829.8 829.9 830.7 494.6 502.2 503.4 506.4 583.1 12791.4 13291.5 13302.4 13309.3 13332.9 12539.7 12561.8 12901.4 12932.0 12986.4 11792.1 11933.6 11995.3 12143.1 12859.4 4198.0 4246.4 4253.7 4293.1 4391.9 67559.0 68064.3 68411.3 68556.7 68625.3 10308.0 10376.3 10391.3 10785.0 11057.7 18926.0 19178.5 19253.5 19267.5 19402.0 6577.1 6658.5 6703.7 6827.9 7026.6 3790.2 3797.5 3800.5 3800.7 3817.9 2782.6 2858.1 2878.0 2878.6 2880.5 466.1 477.5 485.0 486.1 490.8 480.2 481.0 546.9 575.5 585.1 7463.0 7552.4 7991.0 8141.1 8185.1 518.5 553.6 556.9 564.7 601.8 3521.5 3618.4 3848.5 3850.1 3976.9 93106.0 94454.5 95790.5 97102.5 98032.0 78457.0 80062.0 81797.6 83255.2 85054.6 70261.0 70742.6 75301.1 76468.6 78060.0 7127.6 7227.9 7231.0 7273.0 7524.8 41065.2 42282.8 42335.8 42492.4 43057.4 53491.0 54372.5 58946.4 61929.4 64963.7 9163.1 9367.3 9529.8 9538.0 9781.1 11493.7 11607.2 11826.6 12296.5 12312.9 10442.9 10506.2 10677.4 10845.8 10924.9 10027.5 10059.8 10278.4 10282.9 10724.5 9842.2 9979.4 9985.0 10054.0 10354.6 8980.3 9136.5 9300.5 9346.7 9663.0 8456.5 8704.3 8740.4 8755.4 8917.8 14:43:52 INFO - PROCESS | 24619 | -------- Summary: end -------- 14:43:52 INFO - PROCESS | 24619 | 14:43:52 INFO - TEST-INFO | 24619: exit 0 14:43:52 INFO - TEST-OK | dromaeo_css | took 1120011ms 14:43:52 INFO - TEST-START | kraken 14:43:52 INFO - operating with platform_type : linux_ 14:43:52 INFO - Initialising browser for kraken test... 14:43:52 INFO - TEST-INFO | started process 24807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPxZpy/profile http://localhost:60927/getInfo.html) 14:43:57 INFO - PROCESS | 24807 | __metrics Screen width/height:1600/1200 14:43:57 INFO - PROCESS | 24807 | colorDepth:24 14:43:57 INFO - PROCESS | 24807 | Browser inner width/height: 1024/697 14:43:57 INFO - PROCESS | 24807 | __metrics 14:43:58 INFO - PROCESS | 24807 | 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" 14:43:58 INFO - PROCESS | 24807 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:43:59 INFO - TEST-INFO | 24807: exit 0 14:43:59 INFO - Browser initialized. 14:43:59 INFO - Running cycle 1/1 for kraken test... 14:43:59 INFO - TEST-INFO | started process 24887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPxZpy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:11 INFO - PROCESS | 24887 | RSS: Main: 157913088 14:44:11 INFO - PROCESS | 24887 | 14:44:13 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60927/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:14 INFO - PROCESS | 24887 | RSS: Main: 214917120 14:44:14 INFO - PROCESS | 24887 | 14:44:17 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60927/tests/kraken/driver.html?testName=audio-dft) 14:44:18 INFO - PROCESS | 24887 | RSS: Main: 191733760 14:44:18 INFO - PROCESS | 24887 | 14:44:21 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60927/tests/kraken/driver.html?testName=audio-fft) 14:44:21 INFO - PROCESS | 24887 | RSS: Main: 271314944 14:44:21 INFO - PROCESS | 24887 | 14:44:24 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60927/tests/kraken/driver.html?testName=audio-oscillator) 14:44:24 INFO - PROCESS | 24887 | RSS: Main: 180596736 14:44:24 INFO - PROCESS | 24887 | 14:44:26 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:27 INFO - PROCESS | 24887 | RSS: Main: 185524224 14:44:27 INFO - PROCESS | 24887 | 14:44:30 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60927/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:31 INFO - PROCESS | 24887 | RSS: Main: 221761536 14:44:31 INFO - PROCESS | 24887 | 14:44:34 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60927/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:35 INFO - PROCESS | 24887 | RSS: Main: 215097344 14:44:35 INFO - PROCESS | 24887 | 14:44:38 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60927/tests/kraken/driver.html?testName=json-parse-financial) 14:44:39 INFO - PROCESS | 24887 | RSS: Main: 218918912 14:44:39 INFO - PROCESS | 24887 | 14:44:40 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:41 INFO - PROCESS | 24887 | RSS: Main: 184721408 14:44:41 INFO - PROCESS | 24887 | 14:44:43 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:43 INFO - PROCESS | 24887 | RSS: Main: 190189568 14:44:43 INFO - PROCESS | 24887 | 14:44:45 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:46 INFO - PROCESS | 24887 | RSS: Main: 194932736 14:44:46 INFO - PROCESS | 24887 | 14:44:49 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:50 INFO - PROCESS | 24887 | RSS: Main: 189140992 14:44:50 INFO - PROCESS | 24887 | 14:44:52 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:53 INFO - PROCESS | 24887 | RSS: Main: 193384448 14:44:53 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | Cycle 1(1): loaded http://localhost:60927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60927/tests/kraken/driver.html?testName=ai-astar) 14:44:55 INFO - PROCESS | 24887 | RSS: Main: 243843072 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | __start_tp_report 14:44:55 INFO - PROCESS | 24887 | _x_x_mozilla_page_load 14:44:55 INFO - PROCESS | 24887 | _x_x_mozilla_page_load_details 14:44:55 INFO - PROCESS | 24887 | |i|pagename|runs| 14:44:55 INFO - PROCESS | 24887 | |0;ai-astar;104;114;113;112;115;114;113;112;113;114 14:44:55 INFO - PROCESS | 24887 | |1;audio-beat-detection;158;130;125;194;123;129;149;126;163;121 14:44:55 INFO - PROCESS | 24887 | |2;audio-dft;162;162;161;163;161;161;162;162;161;160 14:44:55 INFO - PROCESS | 24887 | |3;audio-fft;76;76;76;121;77;76;76;76;98;74 14:44:55 INFO - PROCESS | 24887 | |4;audio-oscillator;85;86;120;85;85;86;119;84;84;125 14:44:55 INFO - PROCESS | 24887 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 14:44:55 INFO - PROCESS | 24887 | |6;imaging-darkroom;147;147;147;146;147;147;147;147;148;149 14:44:55 INFO - PROCESS | 24887 | |7;imaging-desaturate;95;94;95;96;96;94;95;96;95;96 14:44:55 INFO - PROCESS | 24887 | |8;json-parse-financial;63;63;63;64;68;64;64;62;62;63 14:44:55 INFO - PROCESS | 24887 | |9;json-stringify-tinderbox;64;65;65;65;65;65;66;65;66;65 14:44:55 INFO - PROCESS | 24887 | |10;stanford-crypto-aes;80;78;80;79;89;80;78;79;77;77 14:44:55 INFO - PROCESS | 24887 | |11;stanford-crypto-ccm;130;132;138;140;130;144;128;128;148;136 14:44:55 INFO - PROCESS | 24887 | |12;stanford-crypto-pbkdf2;173;167;172;167;167;171;172;169;171;167 14:44:55 INFO - PROCESS | 24887 | |13;stanford-crypto-sha256-iterative;71;67;68;68;67;68;68;67;77;65 14:44:55 INFO - PROCESS | 24887 | __end_tp_report 14:44:55 INFO - PROCESS | 24887 | __start_cc_report 14:44:55 INFO - PROCESS | 24887 | _x_x_mozilla_cycle_collect,1945 14:44:55 INFO - PROCESS | 24887 | __end_cc_report 14:44:55 INFO - PROCESS | 24887 | __startTimestamp1470347095613__endTimestamp 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | ------- Summary: start ------- 14:44:55 INFO - PROCESS | 24887 | Number of tests: 14 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.10 (2.7%) stddev-sans-first:1.00 14:44:55 INFO - PROCESS | 24887 | Values: 104.0 114.0 113.0 112.0 115.0 114.0 113.0 112.0 113.0 114.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:139.50 stddev:23.83 (17.1%) stddev-sans-first:24.54 14:44:55 INFO - PROCESS | 24887 | Values: 158.0 130.0 125.0 194.0 123.0 129.0 149.0 126.0 163.0 121.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 14:44:55 INFO - PROCESS | 24887 | Values: 162.0 162.0 161.0 163.0 161.0 161.0 162.0 162.0 161.0 160.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:15.20 (20.0%) stddev-sans-first:15.93 14:44:55 INFO - PROCESS | 24887 | Values: 76.0 76.0 76.0 121.0 77.0 76.0 76.0 76.0 98.0 74.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.63 (20.7%) stddev-sans-first:18.25 14:44:55 INFO - PROCESS | 24887 | Values: 85.0 86.0 120.0 85.0 85.0 86.0 119.0 84.0 84.0 125.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:44:55 INFO - PROCESS | 24887 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:44:55 INFO - PROCESS | 24887 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 149.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 14:44:55 INFO - PROCESS | 24887 | Values: 95.0 94.0 95.0 96.0 96.0 94.0 95.0 96.0 95.0 96.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.50 stddev:1.71 (2.7%) stddev-sans-first:1.80 14:44:55 INFO - PROCESS | 24887 | Values: 63.0 63.0 63.0 64.0 68.0 64.0 64.0 62.0 62.0 63.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 14:44:55 INFO - PROCESS | 24887 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:3.47 (4.4%) stddev-sans-first:3.67 14:44:55 INFO - PROCESS | 24887 | Values: 80.0 78.0 80.0 79.0 89.0 80.0 78.0 79.0 77.0 77.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:137.00 stddev:7.00 (5.1%) stddev-sans-first:7.14 14:44:55 INFO - PROCESS | 24887 | Values: 130.0 132.0 138.0 140.0 130.0 144.0 128.0 128.0 148.0 136.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:171.00 stddev:2.46 (1.4%) stddev-sans-first:2.28 14:44:55 INFO - PROCESS | 24887 | Values: 173.0 167.0 172.0 167.0 167.0 171.0 172.0 169.0 171.0 167.0 14:44:55 INFO - PROCESS | 24887 | 14:44:55 INFO - PROCESS | 24887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:3.31 (4.9%) stddev-sans-first:3.39 14:44:55 INFO - PROCESS | 24887 | Values: 71.0 67.0 68.0 68.0 67.0 68.0 68.0 67.0 77.0 65.0 14:44:55 INFO - PROCESS | 24887 | -------- Summary: end -------- 14:44:55 INFO - PROCESS | 24887 | 14:44:56 INFO - TEST-INFO | 24887: exit 0 14:44:56 INFO - TEST-OK | kraken | took 63831ms 14:44:56 INFO - SUITE-END | took 1183s 14:44:56 INFO - Completed test suite (00:19:43) 14:44:56 INFO - javascript benchmark 14:44:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.375429896825, 2604.0755531786203, 2608.6087086936964, 2626.38280004199, 2645.8015648826345, 4627.074585082988, 4698.718076915387, 4723.0553889222165, 4732.313814496896, 4732.787024583893, 4637.350770892078, 4738.265568836827, 4774.689645173062, 4779.689320194185, 4798.952010479894, 4353.25994580922, 4385.144896745128, 4412.24991751403, 4412.40432541606, 4420.86737397877, 4392.363107349448, 4435.201663700533, 4459.576340247671, 4471.150481408538, 4520.457545094593, 4462.709923854955, 4502.459704835408, 4516.39028731122, 4526.0, 4534.0, 4308.763018034007, 4349.565043495657, 4358.259095953696, 4425.977870110629, 4482.170798402306, 4271.060366719348, 4304.945288404329, 4344.391785150082, 4359.04101097758, 4376.540463251376, 4659.324397962277, 4691.7888695008805, 4714.976425117852, 4746.335513028179, 4747.715137091785, 5091.719955402451, 5095.617828662865, 5139.997700448414, 5141.871453213662, 5146.922796158024, 4902.803887844482, 5021.824236151754, 5076.873078173076, 5081.136206844845, 5109.821156259513, 4765.928511072371, 4794.832180873653, 4803.303520989437, 4813.422389313305, 4821.421429428421, 5234.528892399702, 5238.528532432099, 5266.815661451831, 5279.709615971158, 5285.286486324374, 4872.683275587146, 4904.681195722266, 4970.875728106754, 4973.1297023020825, 5037.647364684511, 5062.645614807002, 5067.5185857343495, 5087.465816089331, 5117.385913690381, 5123.538881500608, 5015.899682006339, 5018.749062546858, 5024.748762561931, 5035.471275516092, 5084.77118529667, 4908.337374454474, 4927.137750893579, 5005.9749701251985, 5013.473585273494, 5055.873603159876, 4339.869803905888, 4345.891352716208, 4346.195953748566, 4350.0, 4388.0, 3791.9241615167543, 3811.2568049230135, 3819.25524522721, 3821.140243445258, 3832.770033797981, 4248.086661367821, 4329.15581461612, 4364.890877728082, 4365.607095361433, 4429.0, 5140.280360749498, 5141.53726164647, 5152.149895267239, 5153.793848246103, 5208.921866172011, 4372.256716358227, 4382.320740285261, 4385.144896745168, 4386.824527018947, 4428.3136113901755, 4465.151621191963, 4595.885102872388, 4606.447226332862, 4624.098300831306, 4703.082898834695, 4811.08589368019, 4822.276658501182, 4830.565249127595, 4839.782209800497, 4883.340748998839, 5140.845774626618, 5158.38099428071, 5158.8968220636125, 5163.974180129076, 5203.791848326025, 4626.6530010250035, 4700.882477938079, 4743.312219728189, 4750.334953106499, 4820.035992801384, 4978.352814134139, 5005.374328208974, 5008.298838162587, 5011.098002359465, 5049.899002020013, 5035.16919708244, 5078.873028174177, 5081.949180508295, 5083.87290317745, 5133.589312855037, 4787.305840653016, 4885.780139893643, 4893.681910675795, 4927.310176575354, 4985.102681517362, 4928.852134435972, 4939.75301234944, 4941.135301322326, 4948.257761335828, 4994.850154495371, 4882.877928051827, 4894.608431325557, 4952.207646776498, 4957.801687932442, 4964.602831773522, 4834.854954351375, 4889.90220195587, 4896.020795840775, 4915.5330243626795, 4926.482719314564, 4850.660453768202, 4859.052484765437, 4865.367502224688, 4890.168671325812, 4917.360743103373], "value": 4670.6716259875175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4891373307156, 564.7882044233412, 575.6948817126921, 579.3829571506345, 591.1015256809648, 28064.438711225765, 38573.0, 40102.799486002565, 40136.19727605453, 43651.56348436515, 39633.40549891754, 40003.0, 40020.59979400205, 40032.59967400325, 40130.197396052135, 7464.813379665525, 7593.468457207998, 7602.353799926986, 7604.0875094988405, 7618.238176182393, 7425.257474252586, 9715.222782177409, 9886.209103271722, 9958.302918795687, 10359.378437293786, 10089.899101009007, 10204.795904081951, 10220.0, 10225.23310751693, 10230.386176829414, 10016.449095299755, 10078.697639070839, 10098.040686134806, 10099.242556808269, 10106.140978016878, 9940.552675129637, 10017.649382271658, 10021.398716076987, 10027.047430494164, 10037.598496060149, 38716.22567548662, 39113.413298800544, 39128.41307380392, 39168.41247381292, 39255.60744392548, 2878.3811480531576, 3031.6058912341473, 3140.450421176285, 3188.171075520358, 3612.060864175307, 28739.71260287391, 28774.42451150986, 29078.0, 29172.0, 29776.553351699742, 3473.9826300868335, 3528.5065402467226, 3533.646635336446, 3564.82175891207, 3615.0600843780544, 262502.0, 263573.0, 263833.0, 264424.0, 264594.0, 52110.47889521056, 52338.21492677613, 52381.7380913093, 52400.73799630978, 52488.212676809875, 32147.67852321447, 32896.1775955603, 33002.66997330044, 34808.651913481044, 55058.72470637701, 14965.102093874402, 15181.392744290104, 15233.162176080423, 15237.695246095016, 15247.085174889542, 10319.638812641671, 11180.217384782987, 11397.943010284895, 11456.026237769716, 11466.2546934449, 17209.311627535008, 17716.557086072695, 17850.732239016426, 17891.821081789014, 18104.0, 6747.257801641816, 6830.453563714891, 6867.0, 6977.372036516738, 6977.616231107338, 730.7332823519378, 779.3142035009269, 816.4856140631364, 832.1054866018933, 906.5829718329642, 27537.724622753918, 28601.28496787597, 29359.706402936125, 29369.7063029367, 30618.54072188919, 832.2676045080291, 895.3240303570763, 910.6767097680361, 964.5514835601479, 973.3721749471551, 14165.291735413395, 14984.100953942798, 15083.095014299177, 15190.544283671286, 15297.923510382378, 398598.0, 402201.0, 402705.0, 403249.0, 403255.0, 47438.0, 48091.0, 48091.5190848087, 48115.75942120337, 48125.0, 1070.9410982396043, 1135.9261647992853, 1153.4866984192122, 1159.9246049006788, 1166.3293606176483, 26629.733702662725, 27513.862430687717, 27784.44431111326, 28571.714282856905, 28611.856940715163, 41189.0, 41854.79072604617, 41912.0, 41934.1613167741, 41953.0, 330381.0, 333220.0, 333935.0, 334311.0, 389091.0, 38616.42075368816, 38919.805400972815, 39029.80485097556, 39056.0, 39669.0, 42288.1542369157, 42350.36474452824, 42516.149677006906, 42623.786881065396, 43420.131597368505, 36760.0, 36833.0, 37060.92329843769, 37595.812020940815, 38172.0, 36521.634783651825, 36952.44571331486, 37132.0, 37239.255214895005, 37808.24383512369, 35810.462843056855, 36085.0, 36536.0, 36806.63193368139, 37547.249055019296, 31468.842655786575, 32796.672033280316, 33367.33265334728, 33412.49881251735, 33489.497657534666, 25494.334426033674, 25610.773388212223, 25849.224523264333, 25872.353191170372, 26126.477470450864], "value": 18078.00944472561, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.3666034534386, 348.97382696297785, 358.40146954585833, 364.50427418710547, 382.36336499727935, 12773.361331933402, 16398.754018689713, 17087.743683844754, 17518.0, 18696.81303186968, 15148.621284467894, 17307.82692173081, 17588.120593970314, 17616.0, 17694.203760830762, 4986.700797952134, 5101.770420331075, 5186.351706036746, 5205.687658740469, 5207.947920520804, 3694.3719567673425, 5159.793608255665, 5237.188235823434, 5783.5084017858535, 6086.026235802273, 6153.476954458876, 6176.289726681444, 6181.629102253857, 6181.783637572686, 6182.165407669952, 5920.141579470974, 6142.84642883927, 6163.7842675506145, 6170.444659980579, 6182.443580077769, 5205.947940520584, 5400.459954004607, 5405.162199859028, 5408.4050754416985, 5414.7834086636485, 21066.683999740017, 21278.787212127834, 21378.144874205012, 21397.144114235412, 21413.0, 1905.7427247321573, 2065.8863762493056, 2172.8587641803233, 2312.1791763923734, 2376.823472381165, 12591.811122833165, 13275.668108297274, 13314.800277995837, 13534.0, 13714.382852771649, 1708.6497268060018, 1743.0935913325, 1751.9386821461314, 1803.9098045097692, 1815.754873092129, 44060.0, 44506.0, 65929.3407065928, 70934.64532677355, 71128.64435677789, 9362.719118426457, 9506.857397139049, 9650.806983860424, 9670.421943880809, 10052.64815731446, 13172.143810652276, 13213.933930330288, 13223.801642975362, 13240.0, 13285.0, 7289.70841166358, 7299.4525410594415, 7501.0, 7502.324790768857, 7570.356519695888, 7146.642667866586, 7159.105111861018, 7272.818179545554, 7449.404047676173, 7481.775546733498, 5976.223090998143, 6051.243594550681, 6062.0, 6131.6321020738005, 6303.716332765037, 1493.8580834820675, 1679.9328026878788, 1692.4161164398263, 1697.125980120239, 1705.9573510662085, 716.7276434954683, 828.2007862412801, 850.9319254459629, 930.9991758859253, 977.296346630425, 16527.752083718755, 17054.829451705573, 17722.379716709853, 17823.554411139827, 17936.55158621019, 820.3150369441464, 823.1192623892497, 850.4599579267086, 864.1919804982361, 912.1653686876566, 9626.66306679277, 9693.22454203662, 10503.52734126966, 10532.578696852193, 10654.360738355723, 438822.0, 441961.0, 451413.0, 451852.0, 455961.0, 84993.0, 89298.55350723334, 89912.0, 90078.0, 90630.0, 903.6114470777497, 933.0436302789559, 963.4797209506788, 966.5602151021268, 967.6564819489121, 15829.960519454997, 16017.679646406774, 16077.919610401874, 16777.412790552273, 17012.914935425244, 40883.18233635251, 40996.18007639771, 41066.1786764269, 41169.58830411657, 41860.79069604632, 53383.0, 54305.72847135739, 55541.1668824976, 55591.166132507235, 57189.42810571841, 7439.62801859894, 7494.887576686463, 7523.022007139037, 7618.162002179866, 7964.084130325086, 10456.68629941103, 11322.26405283654, 11327.660170194908, 11491.597794077166, 11968.700782480508, 9734.221262299141, 9946.651867184613, 10020.949895250476, 10022.24833137503, 10810.837837432287, 10162.39025658463, 10167.796644067224, 10249.38503689781, 10380.221483388625, 10629.787404252027, 10413.635522756667, 10442.895571044191, 10561.63034293796, 11019.724506887393, 11039.503222354853, 7494.962525187339, 7537.472376933562, 7584.734534291273, 7623.809404764704, 7699.499532530368, 9052.637894484147, 10240.590376384862, 10266.178705703674, 10499.222371840275, 10654.200934929757], "value": 8534.47643087188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.483528841396, 1375.2848518770238, 1425.5794540610518, 1593.7290660587698, 1647.6210471591535, 6747.359000894913, 7274.308940650643, 7290.161631412389, 7297.70809167634, 7303.269673032701, 6135.8772824543485, 6316.242050953881, 6802.523823332356, 7070.5404148730295, 7168.319009694071, 2093.424308315214, 2116.47088227943, 2120.628889944261, 2120.968185477219, 2124.0654112190587, 2041.7665590140907, 2064.917403303866, 2151.34384012876, 2154.504463973287, 2156.2345367394582, 1762.0661049643709, 2002.429307647321, 2105.757837848652, 2107.757607875091, 2112.8415368847322, 2101.0125241136643, 2107.7892210778878, 2122.755883073451, 2129.0525716056363, 2130.9999999999923, 2064.1227478321653, 2065.2565076572423, 2066.669332906743, 2069.079259729421, 2069.182672844218, 7168.856622867514, 7172.426205903515, 7208.891866622005, 7210.098737657793, 7215.494915355927, 4171.0, 4291.291936830419, 4298.0, 4309.030468144674, 4312.5903039211225, 2731.7814574833965, 2828.1091456191234, 2829.915102546927, 2835.3620435402077, 2843.3033906692785, 842.7935155886786, 898.0166717444388, 914.5153068873508, 920.2270093121743, 924.9815003699888, 9346.485943273117, 9427.198688111519, 9427.622895084189, 9429.481378524179, 9438.244940404751, 3676.7977761223387, 3812.6568608825337, 3905.668018218483, 3963.8216280267457, 3968.761874287552, 8137.430379873471, 8138.674453021813, 8139.674413023531, 8142.145074767182, 8148.755537333889, 4300.913981720348, 4308.89227769302, 4314.029343397773, 4317.611414972667, 4318.222719910446, 3977.2443235785686, 3994.2410941920944, 3994.800259986989, 4003.959960400417, 4007.138465229931, 3145.465270903952, 3280.048785852076, 3292.1111299949357, 3344.0970937846646, 3358.596968363812, 963.7735132243918, 974.1378879691382, 975.1029053271008, 977.7408986618552, 984.8621193032981, 586.7195242814668, 620.3393386043849, 671.1543455246425, 736.4807810493589, 750.3471979377977, 4969.18008528596, 5024.221245706921, 5050.974745126251, 5061.038402703474, 5202.97398513005, 840.5923127283263, 866.913308669128, 875.7066382761719, 877.0615441477557, 881.7310720230263, 3335.5830521184853, 3433.2790114075824, 3462.1690794209208, 3471.9826400867832, 3550.786952782841, 8314.459560128573, 8591.183837535424, 8652.221300082896, 8658.523781191969, 8682.34882383811, 7962.124166341698, 8237.135100814328, 8291.419600628018, 8497.830043399097, 8670.696525621574, 6537.215534135934, 6701.128853249046, 6724.361185687352, 6724.66376681164, 6729.05793188954, 4957.628177886745, 4963.10664080469, 5051.343325367826, 5180.404253510744, 5251.684898906078, 7709.537427754352, 8008.15914328987, 8034.0, 8084.797880053045, 8125.79685507867, 8064.193580641889, 8221.917780822354, 8260.256576908107, 8318.667253309799, 8378.329733621174, 6178.320384757583, 6232.626042437469, 6268.623882567061, 6279.277883043508, 6378.617282963037, 6611.768588099393, 6713.865722685617, 6723.361280678328, 6734.225564060196, 6748.0, 6096.085587161784, 6165.260168779596, 6291.1192433058495, 6419.486441084796, 6427.421532062137, 6230.937690623035, 6241.21984751906, 6270.372962703876, 6271.905921411274, 6319.0, 5829.417058294137, 6002.729877155626, 6022.488088512526, 6030.3668114847305, 6032.366601506778, 4072.490938632671, 4136.276151673505, 4209.515905670887, 4222.071144348239, 4251.723637963522, 4172.666186705117, 4180.143070670444, 4233.0, 4292.484901811803, 4317.740935543878], "value": 3834.0569071170976, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.920534074552, 289.70305436927146, 292.247462783333, 293.8662908376689, 294.28341987261024, 4810.567048965592, 4867.075255701423, 4872.780724867381, 4894.2413925841465, 4923.015396920617, 4803.703000189947, 4806.5193480651915, 4831.661783675144, 4831.767899185712, 4841.782119804609, 3606.1886075632906, 3659.597444281127, 3726.3106325329763, 3763.849446022156, 3845.9038524036914, 3761.322961866863, 3763.1909139534996, 3777.1690228149764, 3779.489768881207, 3789.810509474529, 3737.2338670572603, 3740.4202348635868, 3752.5496940367193, 3753.7935413552245, 3769.8115094245313, 3610.8375123119654, 3676.5588129424373, 3756.906077348061, 3789.0, 3794.430835374716, 3346.263821959165, 3346.498025296201, 3349.6315405305395, 3363.5795525559306, 3371.157210697326, 4734.786934587917, 4746.4541577718655, 4757.952420475785, 4759.762011899391, 4769.379980602499, 4194.91610167798, 4354.412154359153, 4354.517924782875, 4363.47638283408, 4366.969359247965, 5008.198688209869, 5046.7224302663335, 5051.494850514919, 5061.266116413136, 5065.316182315377, 3656.707463402948, 3657.6159503252306, 3662.1943172502006, 3667.8716244931566, 3684.0237337105686, 5069.340985671876, 5267.683938963636, 5282.709450980195, 5290.259363689087, 5294.894102117974, 3752.7185461090526, 3758.248350329945, 3762.6613604775703, 3767.3628460077507, 3772.1889793694486, 3811.1805961718364, 3812.5615554211067, 3813.0848596336677, 3824.6613685209954, 3824.9808750956067, 4302.849400270976, 4323.027318853233, 4328.718633288826, 4337.91552111972, 4352.825886964486, 4783.182390691515, 5013.172826483589, 5013.3983921928875, 5022.347094877716, 5057.772400241998, 1303.1855090568395, 1323.9404226809816, 1323.9735205296033, 1326.9601911942657, 1334.3395019465427, 812.6099472253352, 837.8282452097305, 851.7096598653046, 853.9829203416022, 856.8072183758604, 4280.186764514732, 4361.149575832682, 4486.506484286726, 4487.977560112178, 4495.9325610115875, 5148.613853960968, 5200.60995425337, 5215.634905556574, 5223.190405487156, 5229.816956406507, 4462.642988560908, 4468.084042771224, 4472.485664148665, 4479.178117785839, 4499.6400287976885, 2624.934376640561, 2759.503289407886, 2773.571610620532, 2778.3748656552116, 2781.4715204111153, 4900.240462728283, 4903.362562866876, 4907.460179380265, 4921.458639549646, 4925.458199598042, 5116.692998420107, 5346.732663366894, 5358.892822143535, 5370.167624018283, 5378.51593356592, 4841.201201801663, 4903.901921961469, 4907.411110666671, 4909.435414927258, 4917.262410638433, 5210.47895210476, 5215.791368345223, 5222.8955420892125, 5247.609383513448, 5257.789688412574, 4983.925241121314, 5118.948810511996, 5128.538431541179, 5135.666181698178, 5158.226266060121, 4885.65800393969, 4906.926396104132, 4938.38270216223, 4948.851534453972, 4955.454899961073, 3731.589525152177, 3732.07797984033, 3737.6075512070843, 3743.326201283795, 3760.8307626157434, 5035.345405097314, 5259.658122222043, 5262.131748261494, 5273.920891186712, 5275.683458992473, 5030.974845125751, 5057.7724002419245, 5065.493450654905, 5066.214736715815, 5085.0, 5054.8769516802295, 5059.924101138559, 5060.342155519759, 5074.898502030012, 5095.490450954875, 4871.732054736882, 4926.926096108489, 4957.900841983068, 4984.277279794482, 5031.7484125792835, 4858.514148585255, 4988.950110498994, 5049.091163590589, 5105.412877518985, 5113.667611605234, 4820.276958456259, 4884.413870335582, 4890.682105663121, 4891.87770305731, 4906.190478570996], "value": 3819.684812669907, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.3174673732263, 637.8532937424395, 638.9488840892732, 708.2351060854278, 753.175273075982, 12935.2238865668, 13758.449662013532, 14101.647458813535, 14124.011319207646, 14129.858701412983, 13563.52527661532, 13640.18158910466, 13655.863441365584, 13672.111312764688, 13693.520726774565, 764.7361660227226, 793.8015496125969, 796.3509739562268, 798.1260519730886, 798.3413683710933, 640.7340953504313, 758.8140905478166, 793.9444238903279, 797.5493845977004, 797.6131576185545, 825.9174082591753, 827.8385714785619, 827.8799574061758, 832.7127141136298, 833.8749187621845, 829.0300348592161, 829.6225217526011, 829.8298848736055, 829.9087100418949, 830.6967956695793, 494.5721950512781, 502.18395107949584, 503.3908970146091, 506.37209859773617, 583.067092651758, 12791.360431978457, 13291.468341266338, 13302.401391937387, 13309.267990260532, 13332.866671333357, 12539.686507837287, 12561.795284083613, 12901.419436125398, 12932.0, 12986.350682465933, 11792.127671181286, 11933.641990740205, 11995.28028318295, 12143.089268304824, 12859.421326040258, 4197.957456077387, 4246.447961764981, 4253.6809739269365, 4293.119910418357, 4391.934120988188, 67559.0, 68064.3193568063, 68411.315886841, 68556.6572167141, 68625.31374686239, 10308.0, 10376.325538839952, 10391.324563903323, 10785.0, 11057.668269951915, 18926.0, 19178.52053698641, 19253.518662033282, 19267.51831204231, 19402.0, 6577.079208910756, 6658.500612454085, 6703.698333574904, 6827.931720682829, 7026.648667566601, 3790.2419516096893, 3797.525309336333, 3800.5059342285326, 3800.6959443244473, 3817.866374676873, 2782.638257026614, 2858.0996985949773, 2877.9712202878122, 2878.553824157259, 2880.5391137418333, 466.10275220200975, 477.54394553202303, 484.97817598208167, 486.14195944158587, 490.825756856318, 480.17889409110813, 481.0, 546.8878879829625, 575.4849409778309, 585.0843430031987, 7462.96268518654, 7552.39580833532, 7990.960045199737, 8141.1275406656805, 8185.099639039701, 518.5488624896288, 553.6456667732655, 556.9164625306155, 564.6950646650845, 601.8465291350677, 3521.506989021539, 3618.4029635110437, 3848.5189351331082, 3850.133719912997, 3976.8608098716404, 93106.0, 94454.52772736092, 95790.52104739432, 97102.51448742852, 98032.0, 78457.0, 80062.0, 81797.59101204576, 83255.16744832596, 85054.57472712721, 70261.0, 70742.64628676824, 75301.11747206363, 76468.61765691136, 78060.0, 7127.643617818984, 7227.927720722725, 7230.9638451807405, 7272.96363518179, 7524.849503010018, 41065.178696425304, 42282.78858605687, 42335.7883210582, 42492.362614561425, 43057.354139687304, 53491.0, 54372.456275436736, 58946.410535894094, 61929.38070619416, 64963.67518162379, 9163.129502697233, 9367.250619950251, 9529.761755956157, 9537.952310238681, 9781.070798274437, 11493.712657183638, 11607.245529040585, 11826.645200643994, 12296.508139674313, 12312.938435307766, 10442.947785261025, 10506.159507239556, 10677.412742299248, 10845.837312440162, 10924.890751092706, 10027.49862506857, 10059.798804023732, 10278.383297002203, 10282.897171028193, 10724.517396717323, 9842.163416109424, 9979.401235925867, 9984.950075249577, 10054.044865737744, 10354.585816567253, 8980.281577473917, 9136.451812891248, 9300.534973251446, 9346.672866449642, 9662.951685241529, 8456.492610443393, 8704.303655707401, 8740.388172827841, 8755.387122901591, 8917.821643566962], "value": 6406.70888873049, "unit": "score"}], "name": "dromaeo_css", "value": 6382.836431397612, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 112.0, 115.0, 114.0, 113.0, 112.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 125.0, 194.0, 123.0, 129.0, 149.0, 126.0, 163.0, 121.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 121.0, 77.0, 76.0, 76.0, 76.0, 98.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 120.0, 85.0, 85.0, 86.0, 119.0, 84.0, 84.0, 125.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 149.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 96.0, 94.0, 95.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 68.0, 64.0, 64.0, 62.0, 62.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 80.0, 79.0, 89.0, 80.0, 78.0, 79.0, 77.0, 77.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 138.0, 140.0, 130.0, 144.0, 128.0, 128.0, 148.0, 136.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 167.0, 172.0, 167.0, 167.0, 171.0, 172.0, 169.0, 171.0, 167.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 77.0, 65.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1535.7, "alertThreshold": 2.0}]} 14:44:56 INFO - Return code: 0 14:44:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:56 INFO - # TBPL SUCCESS # 14:44:56 INFO - Running post-action listener: _resource_record_post_action 14:44:56 INFO - [mozharness: 2016-08-04 21:44:56.902998Z] Finished run-tests step (success) 14:44:56 INFO - Running post-run listener: _resource_record_post_run 14:44:56 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 533405696; Read time: 0; Write time: 393400 14:44:56 INFO - TinderboxPrint: CPU usage
13.0% 14:44:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:44:56 INFO - TinderboxPrint: I/O write bytes / time
533,405,696 / 393,400 14:44:56 INFO - TinderboxPrint: CPU idle
8,333.0 (87.0%) 14:44:56 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 14:44:56 INFO - TinderboxPrint: Swap in / out
0 / 0 14:44:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248791040; Read time: 0; Write time: 224604 14:44:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284614656; Read time: 0; Write time: 168796 14:44:57 INFO - Running post-run listener: _upload_blobber_files 14:44:57 INFO - Blob upload gear active. 14:44:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:57 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 14:44:57 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'] 14:44:57 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 14:44:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:03 INFO - (blobuploader) - INFO - Done attempting. 14:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:04 INFO - (blobuploader) - INFO - Done attempting. 14:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:05 INFO - (blobuploader) - INFO - Done attempting. 14:45:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:45:05 INFO - Return code: 0 14:45:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:45:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:45:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c09759c022ecca183aaee4616ac9cd74f884ee4af74636a99d3894cef12664c11ddf57044cab177bf89e76a88577e9eb2d0f2ed957dfc40c9d361d819db775c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68371177c75577bbc581d7638d84b2ae0dba0819189ab24f625186f5e0afcd4b6b4c94d9654d5744ce2ec9331de178a07e54d1f03fb2970dc164da0d423d9e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d6640c8ba41aa30e1309abb94a28ad816155eaf27bc9abb932ab63e862c5151bd01d5152e52c28472e5233418e5ff0dd6d4303e68f17bd7fe8f018a1e898f67"} 14:45:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:45:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:45:05 INFO - Contents: 14:45:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c09759c022ecca183aaee4616ac9cd74f884ee4af74636a99d3894cef12664c11ddf57044cab177bf89e76a88577e9eb2d0f2ed957dfc40c9d361d819db775c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68371177c75577bbc581d7638d84b2ae0dba0819189ab24f625186f5e0afcd4b6b4c94d9654d5744ce2ec9331de178a07e54d1f03fb2970dc164da0d423d9e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d6640c8ba41aa30e1309abb94a28ad816155eaf27bc9abb932ab63e862c5151bd01d5152e52c28472e5233418e5ff0dd6d4303e68f17bd7fe8f018a1e898f67"} 14:45:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:45:05 INFO - Copying logs to upload dir... 14:45:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:45:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.914097 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-04 14:45:05.035176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 14:45:05.038373) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114 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/c09759c022ecca183aaee4616ac9cd74f884ee4af74636a99d3894cef12664c11ddf57044cab177bf89e76a88577e9eb2d0f2ed957dfc40c9d361d819db775c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68371177c75577bbc581d7638d84b2ae0dba0819189ab24f625186f5e0afcd4b6b4c94d9654d5744ce2ec9331de178a07e54d1f03fb2970dc164da0d423d9e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d6640c8ba41aa30e1309abb94a28ad816155eaf27bc9abb932ab63e862c5151bd01d5152e52c28472e5233418e5ff0dd6d4303e68f17bd7fe8f018a1e898f67"} build_url:https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/IEg-aYiiSzqOAPGetDzBeQ/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/c09759c022ecca183aaee4616ac9cd74f884ee4af74636a99d3894cef12664c11ddf57044cab177bf89e76a88577e9eb2d0f2ed957dfc40c9d361d819db775c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68371177c75577bbc581d7638d84b2ae0dba0819189ab24f625186f5e0afcd4b6b4c94d9654d5744ce2ec9331de178a07e54d1f03fb2970dc164da0d423d9e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d6640c8ba41aa30e1309abb94a28ad816155eaf27bc9abb932ab63e862c5151bd01d5152e52c28472e5233418e5ff0dd6d4303e68f17bd7fe8f018a1e898f67"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 14:45:05.067696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:45:05.068519) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470342910.324242-1961403114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 14:45:05.151710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 14:45:05.152512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 14:45:05.153307) ========= ========= Total master_lag: 0.22 =========