builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1472750152.32 results: success (0) buildid: 20160901083921 builduid: f7b094b75d9b4bdb8aa2c551b3cfb1a4 revision: 737088027e6823ba0206d83735a185f80a89bd77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.319610) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.320015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.320453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.338182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.338530) ========= 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=836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 10:15:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.5M=0s 2016-09-01 10:15:52 (60.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107140 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.740912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.741214) ========= 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=836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014161 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.777070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:52.777439) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 737088027e6823ba0206d83735a185f80a89bd77 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 737088027e6823ba0206d83735a185f80a89bd77 --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=836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 10:15:52,858 truncating revision to first 12 chars 2016-09-01 10:15:52,858 Setting DEBUG logging. 2016-09-01 10:15:52,858 attempt 1/10 2016-09-01 10:15:52,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/737088027e68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 10:15:53,166 unpacking tar archive at: autoland-737088027e68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:53.424903) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:53.425262) ========= script_repo_revision: 737088027e6823ba0206d83735a185f80a89bd77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:53.425656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:53.425918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 10:15:53.435214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-01 10:15:53.435506) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:53 INFO - MultiFileLogger online at 20160901 10:15:53 in /builds/slave/test 10:15:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 10:15:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:53 INFO - {'append_to_log': False, 10:15:53 INFO - 'base_work_dir': '/builds/slave/test', 10:15:53 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 10:15:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:53 INFO - 'branch': 'Autoland-Non-PGO', 10:15:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:53 INFO - 'config_files': ('talos/linux_config.py',), 10:15:53 INFO - 'default_actions': ('clobber', 10:15:53 INFO - 'read-buildbot-config', 10:15:53 INFO - 'download-and-extract', 10:15:53 INFO - 'populate-webroot', 10:15:53 INFO - 'create-virtualenv', 10:15:53 INFO - 'install', 10:15:53 INFO - 'run-tests'), 10:15:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:53 INFO - 'download_minidump_stackwalk': True, 10:15:53 INFO - 'download_symbols': 'ondemand', 10:15:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:53 INFO - 'installer_path': 'installer.exe', 10:15:53 INFO - 'log_level': 'info', 10:15:53 INFO - 'log_name': 'talos', 10:15:53 INFO - 'log_to_console': True, 10:15:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:53 INFO - 'opt_config_files': (), 10:15:53 INFO - 'pip_index': False, 10:15:53 INFO - 'sps_profile': False, 10:15:53 INFO - 'sps_profile_interval': 0, 10:15:53 INFO - 'suite': 'dromaeojs', 10:15:53 INFO - 'system_bits': '32', 10:15:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:53 INFO - 'title': 'talos-linux64-ix-028', 10:15:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:53 INFO - 'use_talos_json': True, 10:15:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:53 INFO - 'work_dir': 'build'} 10:15:53 INFO - [mozharness: 2016-09-01 17:15:53.614043Z] Running clobber step. 10:15:53 INFO - Running pre-action listener: _resource_record_pre_action 10:15:53 INFO - Running main action method: clobber 10:15:53 INFO - rmtree: /builds/slave/test/build 10:15:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - [mozharness: 2016-09-01 17:15:54.072906Z] Finished clobber step (success) 10:15:54 INFO - [mozharness: 2016-09-01 17:15:54.073008Z] Running read-buildbot-config step. 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: read_buildbot_config 10:15:54 INFO - Using buildbot properties: 10:15:54 INFO - { 10:15:54 INFO - "project": "", 10:15:54 INFO - "product": "firefox", 10:15:54 INFO - "script_repo_revision": "production", 10:15:54 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:15:54 INFO - "repository": "", 10:15:54 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 10:15:54 INFO - "buildid": "20160901083921", 10:15:54 INFO - "pgo_build": "False", 10:15:54 INFO - "basedir": "/builds/slave/test", 10:15:54 INFO - "buildnumber": 391, 10:15:54 INFO - "slavename": "talos-linux64-ix-028", 10:15:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:15:54 INFO - "platform": "ubuntu64_hw", 10:15:54 INFO - "scheduler": "tests-autoland-linux64-talos", 10:15:54 INFO - "branch": "autoland", 10:15:54 INFO - "repo_path": "integration/autoland", 10:15:54 INFO - "revision": "737088027e6823ba0206d83735a185f80a89bd77", 10:15:54 INFO - "stage_platform": "linux64", 10:15:54 INFO - "builduid": "f7b094b75d9b4bdb8aa2c551b3cfb1a4", 10:15:54 INFO - "slavebuilddir": "test" 10:15:54 INFO - } 10:15:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - [mozharness: 2016-09-01 17:15:54.075718Z] Finished read-buildbot-config step (success) 10:15:54 INFO - [mozharness: 2016-09-01 17:15:54.075807Z] Running download-and-extract step. 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: download_and_extract 10:15:54 INFO - mkdir: /builds/slave/test/build/tests 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:54 INFO - trying https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:15:54 INFO - Downloaded 1361 bytes. 10:15:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:15:54 INFO - Using the following test package requirements: 10:15:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:15:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'jsshell-linux-x86_64.zip'], 10:15:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:54 INFO - trying https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:15:55 INFO - Downloaded 20333746 bytes. 10:15:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:15:59 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 10:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:59 INFO - trying https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:15:59 INFO - Downloading https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:16:00 INFO - Downloaded 20333746 bytes. 10:16:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:05 INFO - trying https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:16:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:16:05 INFO - Downloaded 14413998 bytes. 10:16:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 10:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:06 INFO - trying https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:16:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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 10:16:07 INFO - Downloaded 55868639 bytes. 10:16:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:16:07 INFO - mkdir: /builds/slave/test/properties 10:16:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:07 INFO - Contents: 10:16:07 INFO - build_url:https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:16:07 INFO - Running post-action listener: _resource_record_post_action 10:16:07 INFO - Running post-action listener: set_extra_try_arguments 10:16:07 INFO - [mozharness: 2016-09-01 17:16:07.936329Z] Finished download-and-extract step (success) 10:16:07 INFO - [mozharness: 2016-09-01 17:16:07.936628Z] Running populate-webroot step. 10:16:07 INFO - Running pre-action listener: _resource_record_pre_action 10:16:07 INFO - Running main action method: populate_webroot 10:16:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:16:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:16:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:16:07 INFO - '--tppagecycles', 10:16:07 INFO - '7'], 10:16:07 INFO - 'tests': ['tsvgm']}}, 10:16:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:16:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:16:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:16:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:16:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['damp', 'tps']}, 10:16:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'tests': ['damp', 'tps']}, 10:16:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['dromaeo_dom']}, 10:16:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['basic_compositor_video']}, 10:16:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:16:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['a11yr', 10:16:07 INFO - 'ts_paint', 10:16:07 INFO - 'tpaint', 10:16:07 INFO - 'sessionrestore', 10:16:07 INFO - 'sessionrestore_no_auto_restore', 10:16:07 INFO - 'tabpaint']}, 10:16:07 INFO - 'other-e10s': {'tests': ['a11yr', 10:16:07 INFO - 'ts_paint', 10:16:07 INFO - 'tpaint', 10:16:07 INFO - 'sessionrestore', 10:16:07 INFO - 'sessionrestore_no_auto_restore', 10:16:07 INFO - 'tabpaint']}, 10:16:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:16:07 INFO - 'ts_paint', 10:16:07 INFO - 'tpaint', 10:16:07 INFO - 'sessionrestore', 10:16:07 INFO - 'sessionrestore_no_auto_restore', 10:16:07 INFO - 'tabpaint']}, 10:16:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:16:07 INFO - 'ts_paint', 10:16:07 INFO - 'tpaint', 10:16:07 INFO - 'sessionrestore', 10:16:07 INFO - 'sessionrestore_no_auto_restore', 10:16:07 INFO - 'tabpaint']}, 10:16:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['a11yr', 10:16:07 INFO - 'ts_paint', 10:16:07 INFO - 'tpaint', 10:16:07 INFO - 'sessionrestore', 10:16:07 INFO - 'sessionrestore_no_auto_restore', 10:16:07 INFO - 'tabpaint']}, 10:16:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['a11yr', 10:16:07 INFO - 'ts_paint', 10:16:07 INFO - 'tpaint', 10:16:07 INFO - 'sessionrestore', 10:16:07 INFO - 'sessionrestore_no_auto_restore', 10:16:07 INFO - 'tabpaint']}, 10:16:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['tsvgx', 10:16:07 INFO - 'tsvgr_opacity', 10:16:07 INFO - 'tart', 10:16:07 INFO - 'tscrollx', 10:16:07 INFO - 'cart']}, 10:16:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:16:07 INFO - 'tsvgr_opacity', 10:16:07 INFO - 'tart', 10:16:07 INFO - 'tscrollx', 10:16:07 INFO - 'cart']}, 10:16:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'talos_options': ['--disable-e10s'], 10:16:07 INFO - 'tests': ['tp5o']}, 10:16:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'tests': ['tp5o']}, 10:16:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'talos_options': ['--disable-e10s', 10:16:07 INFO - '--xperf_path', 10:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:07 INFO - 'tests': ['tp5n']}, 10:16:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:07 INFO - 'talos_options': ['--xperf_path', 10:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:07 INFO - 'tests': ['tp5n']}}, 10:16:07 INFO - 'talos.zip': {'path': '', 10:16:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:16:07 INFO - Running post-action listener: _resource_record_post_action 10:16:07 INFO - [mozharness: 2016-09-01 17:16:07.955042Z] Finished populate-webroot step (success) 10:16:07 INFO - [mozharness: 2016-09-01 17:16:07.955137Z] Running create-virtualenv step. 10:16:07 INFO - Running pre-action listener: _resource_record_pre_action 10:16:07 INFO - Running main action method: create_virtualenv 10:16:07 INFO - Creating virtualenv /builds/slave/test/build/venv 10:16:07 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 10:16:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:16:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:08 INFO - Using real prefix '/usr' 10:16:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:16:08 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:10 INFO - Installing pip.................done. 10:16:10 INFO - Return code: 0 10:16:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:10 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:10 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 10:16:10 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 10:16:10 INFO - Using env: {'DISPLAY': ':0', 10:16:10 INFO - 'HOME': '/home/cltbld', 10:16:10 INFO - 'LANG': 'en_US.UTF-8', 10:16:10 INFO - 'LANGUAGE': 'en_US:en', 10:16:10 INFO - 'LOGNAME': 'cltbld', 10:16:10 INFO - 'MAIL': '/var/mail/cltbld', 10:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:10 INFO - 'MOZ_NO_REMOTE': '1', 10:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:10 INFO - 'NO_EM_RESTART': '1', 10:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:10 INFO - 'PWD': '/builds/slave/test', 10:16:10 INFO - 'SHELL': '/bin/bash', 10:16:10 INFO - 'SHLVL': '1', 10:16:10 INFO - 'TERM': 'linux', 10:16:10 INFO - 'TMOUT': '86400', 10:16:10 INFO - 'USER': 'cltbld', 10:16:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:10 INFO - '_': '/tools/buildbot/bin/python'} 10:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:10 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 10:16:10 INFO - Cleaning up... 10:16:10 INFO - Return code: 0 10:16:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:10 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:10 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 10:16:10 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 10:16:10 INFO - Using env: {'DISPLAY': ':0', 10:16:10 INFO - 'HOME': '/home/cltbld', 10:16:10 INFO - 'LANG': 'en_US.UTF-8', 10:16:10 INFO - 'LANGUAGE': 'en_US:en', 10:16:10 INFO - 'LOGNAME': 'cltbld', 10:16:10 INFO - 'MAIL': '/var/mail/cltbld', 10:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:10 INFO - 'MOZ_NO_REMOTE': '1', 10:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:10 INFO - 'NO_EM_RESTART': '1', 10:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:10 INFO - 'PWD': '/builds/slave/test', 10:16:10 INFO - 'SHELL': '/bin/bash', 10:16:10 INFO - 'SHLVL': '1', 10:16:10 INFO - 'TERM': 'linux', 10:16:10 INFO - 'TMOUT': '86400', 10:16:10 INFO - 'USER': 'cltbld', 10:16:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:10 INFO - '_': '/tools/buildbot/bin/python'} 10:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:10 INFO - Downloading/unpacking psutil>=3.1.1 10:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:16:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:12 INFO - Installing collected packages: psutil 10:16:12 INFO - Running setup.py install for psutil 10:16:13 INFO - building 'psutil._psutil_linux' extension 10:16:13 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 10:16:13 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 10:16:13 INFO - building 'psutil._psutil_posix' extension 10:16:13 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 10:16:13 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 10:16:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:13 INFO - Successfully installed psutil 10:16:13 INFO - Cleaning up... 10:16:13 INFO - Return code: 0 10:16:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:13 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:13 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 10:16:13 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 10:16:13 INFO - Using env: {'DISPLAY': ':0', 10:16:13 INFO - 'HOME': '/home/cltbld', 10:16:13 INFO - 'LANG': 'en_US.UTF-8', 10:16:13 INFO - 'LANGUAGE': 'en_US:en', 10:16:13 INFO - 'LOGNAME': 'cltbld', 10:16:13 INFO - 'MAIL': '/var/mail/cltbld', 10:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:13 INFO - 'MOZ_NO_REMOTE': '1', 10:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:13 INFO - 'NO_EM_RESTART': '1', 10:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:13 INFO - 'PWD': '/builds/slave/test', 10:16:13 INFO - 'SHELL': '/bin/bash', 10:16:13 INFO - 'SHLVL': '1', 10:16:13 INFO - 'TERM': 'linux', 10:16:13 INFO - 'TMOUT': '86400', 10:16:13 INFO - 'USER': 'cltbld', 10:16:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:13 INFO - '_': '/tools/buildbot/bin/python'} 10:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:16:13 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 10:16:13 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 10:16:13 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 10:16:13 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 10:16:13 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 10:16:13 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 10:16:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:16:15 INFO - Installing collected packages: mozsystemmonitor 10:16:15 INFO - Running setup.py install for mozsystemmonitor 10:16:15 INFO - Successfully installed mozsystemmonitor 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:16:15 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')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:15 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 10:16:15 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 10:16:15 INFO - Using env: {'DISPLAY': ':0', 10:16:15 INFO - 'HOME': '/home/cltbld', 10:16:15 INFO - 'LANG': 'en_US.UTF-8', 10:16:15 INFO - 'LANGUAGE': 'en_US:en', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MAIL': '/var/mail/cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SHLVL': '1', 10:16:15 INFO - 'TERM': 'linux', 10:16:15 INFO - 'TMOUT': '86400', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - '_': '/tools/buildbot/bin/python'} 10:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:16 INFO - Downloading/unpacking jsonschema==2.5.1 10:16:16 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 10:16:16 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 10:16:16 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 10:16:16 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 10:16:16 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 10:16:16 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 10:16:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:16:17 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 10:16:17 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 10:16:17 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 10:16:17 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 10:16:17 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 10:16:17 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 10:16:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:18 INFO - warning: no files found matching '*.txt' 10:16:18 INFO - no previously-included directories found matching 'build' 10:16:18 INFO - no previously-included directories found matching 'dist' 10:16:18 INFO - no previously-included directories found matching '.git*' 10:16:18 INFO - Installing collected packages: jsonschema, functools32 10:16:18 INFO - Running setup.py install for functools32 10:16:18 INFO - warning: no files found matching '*.txt' 10:16:18 INFO - no previously-included directories found matching 'build' 10:16:18 INFO - no previously-included directories found matching 'dist' 10:16:18 INFO - no previously-included directories found matching '.git*' 10:16:18 INFO - Successfully installed jsonschema functools32 10:16:18 INFO - Cleaning up... 10:16:18 INFO - Return code: 0 10:16:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:18 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 10:16:18 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 10:16:18 INFO - Using env: {'DISPLAY': ':0', 10:16:18 INFO - 'HOME': '/home/cltbld', 10:16:18 INFO - 'LANG': 'en_US.UTF-8', 10:16:18 INFO - 'LANGUAGE': 'en_US:en', 10:16:18 INFO - 'LOGNAME': 'cltbld', 10:16:18 INFO - 'MAIL': '/var/mail/cltbld', 10:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:18 INFO - 'MOZ_NO_REMOTE': '1', 10:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:18 INFO - 'NO_EM_RESTART': '1', 10:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:18 INFO - 'PWD': '/builds/slave/test', 10:16:18 INFO - 'SHELL': '/bin/bash', 10:16:18 INFO - 'SHLVL': '1', 10:16:18 INFO - 'TERM': 'linux', 10:16:18 INFO - 'TMOUT': '86400', 10:16:18 INFO - 'USER': 'cltbld', 10:16:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:18 INFO - '_': '/tools/buildbot/bin/python'} 10:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:16:18 INFO - Cleaning up... 10:16:18 INFO - Return code: 0 10:16:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:18 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:18 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 10:16:18 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 10:16:18 INFO - Using env: {'DISPLAY': ':0', 10:16:18 INFO - 'HOME': '/home/cltbld', 10:16:18 INFO - 'LANG': 'en_US.UTF-8', 10:16:18 INFO - 'LANGUAGE': 'en_US:en', 10:16:18 INFO - 'LOGNAME': 'cltbld', 10:16:18 INFO - 'MAIL': '/var/mail/cltbld', 10:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:18 INFO - 'MOZ_NO_REMOTE': '1', 10:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:18 INFO - 'NO_EM_RESTART': '1', 10:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:18 INFO - 'PWD': '/builds/slave/test', 10:16:18 INFO - 'SHELL': '/bin/bash', 10:16:18 INFO - 'SHLVL': '1', 10:16:18 INFO - 'TERM': 'linux', 10:16:18 INFO - 'TMOUT': '86400', 10:16:18 INFO - 'USER': 'cltbld', 10:16:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:18 INFO - '_': '/tools/buildbot/bin/python'} 10:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:18 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:18 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 10:16:18 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 10:16:18 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 10:16:18 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 10:16:18 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 10:16:18 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 10:16:20 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:20 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 10:16:20 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 10:16:20 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 10:16:20 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 10:16:20 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 10:16:20 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 10:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:21 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 10:16:21 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 10:16:21 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 10:16:21 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 10:16:21 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 10:16:21 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 10:16:21 INFO - Downloading docopt-0.6.1.tar.gz 10:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:21 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:21 INFO - Running setup.py install for blobuploader 10:16:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:21 INFO - Running setup.py install for requests 10:16:21 INFO - Running setup.py install for docopt 10:16:21 INFO - Successfully installed blobuploader requests docopt 10:16:21 INFO - Cleaning up... 10:16:22 INFO - Return code: 0 10:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:22 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')]} 10:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:22 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')]} 10:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:22 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:22 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 10:16:22 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 10:16:22 INFO - Using env: {'DISPLAY': ':0', 10:16:22 INFO - 'HOME': '/home/cltbld', 10:16:22 INFO - 'LANG': 'en_US.UTF-8', 10:16:22 INFO - 'LANGUAGE': 'en_US:en', 10:16:22 INFO - 'LOGNAME': 'cltbld', 10:16:22 INFO - 'MAIL': '/var/mail/cltbld', 10:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:22 INFO - 'MOZ_NO_REMOTE': '1', 10:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:22 INFO - 'NO_EM_RESTART': '1', 10:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:22 INFO - 'PWD': '/builds/slave/test', 10:16:22 INFO - 'SHELL': '/bin/bash', 10:16:22 INFO - 'SHLVL': '1', 10:16:22 INFO - 'TERM': 'linux', 10:16:22 INFO - 'TMOUT': '86400', 10:16:22 INFO - 'USER': 'cltbld', 10:16:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:22 INFO - '_': '/tools/buildbot/bin/python'} 10:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:22 INFO - Running setup.py (path:/tmp/pip-s1v9KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:22 INFO - Running setup.py (path:/tmp/pip-21Zy7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:22 INFO - Running setup.py (path:/tmp/pip-0aAj2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:22 INFO - Running setup.py (path:/tmp/pip-YlLtLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:22 INFO - Running setup.py (path:/tmp/pip-7pnG6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:22 INFO - Running setup.py (path:/tmp/pip-389pqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:22 INFO - Running setup.py (path:/tmp/pip-G77cC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:22 INFO - Running setup.py (path:/tmp/pip-tPOWVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:22 INFO - Running setup.py (path:/tmp/pip-oeAYFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:22 INFO - Running setup.py (path:/tmp/pip-225JL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:23 INFO - Running setup.py (path:/tmp/pip-VeKuqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:23 INFO - Running setup.py (path:/tmp/pip-zULtEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:23 INFO - Running setup.py (path:/tmp/pip-t4SoDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:23 INFO - Running setup.py (path:/tmp/pip-00eZKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:23 INFO - Running setup.py (path:/tmp/pip-Rvamho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:23 INFO - Running setup.py (path:/tmp/pip-jBs34U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:23 INFO - Running setup.py (path:/tmp/pip-UC1Rsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:23 INFO - Running setup.py install for manifestparser 10:16:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:23 INFO - Running setup.py install for mozcrash 10:16:23 INFO - Running setup.py install for mozdebug 10:16:23 INFO - Running setup.py install for mozdevice 10:16:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:23 INFO - Running setup.py install for mozfile 10:16:24 INFO - Running setup.py install for mozhttpd 10:16:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Running setup.py install for mozinfo 10:16:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Running setup.py install for mozInstall 10:16:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Running setup.py install for mozleak 10:16:24 INFO - Running setup.py install for mozlog 10:16:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Running setup.py install for moznetwork 10:16:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Running setup.py install for mozprocess 10:16:24 INFO - Running setup.py install for mozprofile 10:16:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Running setup.py install for mozrunner 10:16:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:24 INFO - Running setup.py install for mozscreenshot 10:16:25 INFO - Running setup.py install for moztest 10:16:25 INFO - Running setup.py install for mozversion 10:16:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:25 INFO - Cleaning up... 10:16:25 INFO - Return code: 0 10:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:25 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:25 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 10:16:25 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 10:16:25 INFO - Using env: {'DISPLAY': ':0', 10:16:25 INFO - 'HOME': '/home/cltbld', 10:16:25 INFO - 'LANG': 'en_US.UTF-8', 10:16:25 INFO - 'LANGUAGE': 'en_US:en', 10:16:25 INFO - 'LOGNAME': 'cltbld', 10:16:25 INFO - 'MAIL': '/var/mail/cltbld', 10:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:25 INFO - 'MOZ_NO_REMOTE': '1', 10:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:25 INFO - 'NO_EM_RESTART': '1', 10:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:25 INFO - 'PWD': '/builds/slave/test', 10:16:25 INFO - 'SHELL': '/bin/bash', 10:16:25 INFO - 'SHLVL': '1', 10:16:25 INFO - 'TERM': 'linux', 10:16:25 INFO - 'TMOUT': '86400', 10:16:25 INFO - 'USER': 'cltbld', 10:16:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:25 INFO - '_': '/tools/buildbot/bin/python'} 10:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:25 INFO - Running setup.py (path:/tmp/pip-ytP9_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:25 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)) 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:25 INFO - Running setup.py (path:/tmp/pip-HXmPAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:25 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)) 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:25 INFO - Running setup.py (path:/tmp/pip-kId3e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:25 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)) 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:25 INFO - Running setup.py (path:/tmp/pip-XkXZAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:25 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)) 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:25 INFO - Running setup.py (path:/tmp/pip-Vr1inJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:25 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)) 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:25 INFO - Running setup.py (path:/tmp/pip-IvZKTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:25 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)) 10:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:25 INFO - Running setup.py (path:/tmp/pip-GgeSUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:26 INFO - Running setup.py (path:/tmp/pip-GM1t7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:26 INFO - Running setup.py (path:/tmp/pip-DTXtGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:26 INFO - Running setup.py (path:/tmp/pip-Kpsqvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:26 INFO - Running setup.py (path:/tmp/pip-bd30BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:26 INFO - Running setup.py (path:/tmp/pip-VEyjIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:26 INFO - Running setup.py (path:/tmp/pip-LaPDN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:26 INFO - Running setup.py (path:/tmp/pip-hPXK4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:26 INFO - Running setup.py (path:/tmp/pip-E58h9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:26 INFO - Running setup.py (path:/tmp/pip-gzNmYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:26 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)) 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:26 INFO - Running setup.py (path:/tmp/pip-JG9kjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:26 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)) 10:16:26 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)) 10:16:26 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)) 10:16:26 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)) 10:16:26 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)) 10:16:26 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)) 10:16:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:26 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 10:16:26 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 10:16:26 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 10:16:26 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 10:16:26 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 10:16:26 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 10:16:28 INFO - Downloading blessings-1.6.tar.gz 10:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:28 INFO - Installing collected packages: blessings 10:16:28 INFO - Running setup.py install for blessings 10:16:28 INFO - Successfully installed blessings 10:16:28 INFO - Cleaning up... 10:16:28 INFO - Return code: 0 10:16:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:29 INFO - Reading from file tmpfile_stdout 10:16:29 INFO - Current package versions: 10:16:29 INFO - argparse == 1.2.1 10:16:29 INFO - blessings == 1.6 10:16:29 INFO - blobuploader == 1.2.4 10:16:29 INFO - docopt == 0.6.1 10:16:29 INFO - functools32 == 3.2.3-2 10:16:29 INFO - jsonschema == 2.5.1 10:16:29 INFO - manifestparser == 1.1 10:16:29 INFO - mozInstall == 1.12 10:16:29 INFO - mozcrash == 0.17 10:16:29 INFO - mozdebug == 0.1 10:16:29 INFO - mozdevice == 0.48 10:16:29 INFO - mozfile == 1.2 10:16:29 INFO - mozhttpd == 0.7 10:16:29 INFO - mozinfo == 0.9 10:16:29 INFO - mozleak == 0.1 10:16:29 INFO - mozlog == 3.3 10:16:29 INFO - moznetwork == 0.27 10:16:29 INFO - mozprocess == 0.23 10:16:29 INFO - mozprofile == 0.28 10:16:29 INFO - mozrunner == 6.12 10:16:29 INFO - mozscreenshot == 0.1 10:16:29 INFO - mozsystemmonitor == 0.3 10:16:29 INFO - moztest == 0.7 10:16:29 INFO - mozversion == 1.4 10:16:29 INFO - psutil == 3.1.1 10:16:29 INFO - requests == 1.2.3 10:16:29 INFO - wsgiref == 0.1.2 10:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:29 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 10:16:29 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 10:16:29 INFO - Using env: {'DISPLAY': ':0', 10:16:29 INFO - 'HOME': '/home/cltbld', 10:16:29 INFO - 'LANG': 'en_US.UTF-8', 10:16:29 INFO - 'LANGUAGE': 'en_US:en', 10:16:29 INFO - 'LOGNAME': 'cltbld', 10:16:29 INFO - 'MAIL': '/var/mail/cltbld', 10:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:29 INFO - 'MOZ_NO_REMOTE': '1', 10:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:29 INFO - 'NO_EM_RESTART': '1', 10:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:29 INFO - 'PWD': '/builds/slave/test', 10:16:29 INFO - 'SHELL': '/bin/bash', 10:16:29 INFO - 'SHLVL': '1', 10:16:29 INFO - 'TERM': 'linux', 10:16:29 INFO - 'TMOUT': '86400', 10:16:29 INFO - 'USER': 'cltbld', 10:16:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:29 INFO - '_': '/tools/buildbot/bin/python'} 10:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 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)) 10:16:29 INFO - Cleaning up... 10:16:29 INFO - Return code: 0 10:16:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 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 0x7f3dd05f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a21230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, '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': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', '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 10:16:29 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 10:16:29 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 10:16:29 INFO - Using env: {'DISPLAY': ':0', 10:16:29 INFO - 'HOME': '/home/cltbld', 10:16:29 INFO - 'LANG': 'en_US.UTF-8', 10:16:29 INFO - 'LANGUAGE': 'en_US:en', 10:16:29 INFO - 'LOGNAME': 'cltbld', 10:16:29 INFO - 'MAIL': '/var/mail/cltbld', 10:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:29 INFO - 'MOZ_NO_REMOTE': '1', 10:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:29 INFO - 'NO_EM_RESTART': '1', 10:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:29 INFO - 'PWD': '/builds/slave/test', 10:16:29 INFO - 'SHELL': '/bin/bash', 10:16:29 INFO - 'SHLVL': '1', 10:16:29 INFO - 'TERM': 'linux', 10:16:29 INFO - 'TMOUT': '86400', 10:16:29 INFO - 'USER': 'cltbld', 10:16:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:29 INFO - '_': '/tools/buildbot/bin/python'} 10:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:16:29 INFO - Cleaning up... 10:16:29 INFO - Return code: 0 10:16:29 INFO - Running post-action listener: _resource_record_post_action 10:16:29 INFO - Running post-action listener: _start_resource_monitoring 10:16:29 INFO - Starting resource monitoring. 10:16:29 INFO - [mozharness: 2016-09-01 17:16:29.582665Z] Finished create-virtualenv step (success) 10:16:29 INFO - [mozharness: 2016-09-01 17:16:29.583178Z] Running install step. 10:16:29 INFO - Running pre-action listener: _resource_record_pre_action 10:16:29 INFO - Running main action method: install 10:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:29 INFO - Reading from file tmpfile_stdout 10:16:29 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:29 INFO - Reading from file tmpfile_stdout 10:16:29 INFO - Output received: 10:16:29 INFO - Usage: mozinstall [options] installer 10:16:29 INFO - Options: 10:16:29 INFO - -h, --help show this help message and exit 10:16:29 INFO - -d DEST, --destination=DEST 10:16:29 INFO - Directory to install application into. [default: 10:16:29 INFO - "/builds/slave/test"] 10:16:29 INFO - --app=APP Application being installed. [default: firefox] 10:16:29 INFO - mkdir: /builds/slave/test/build/application 10:16:29 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'] 10:16:29 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 10:16:46 INFO - Reading from file tmpfile_stdout 10:16:46 INFO - Output received: 10:16:46 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:46 INFO - Running post-action listener: _resource_record_post_action 10:16:46 INFO - [mozharness: 2016-09-01 17:16:46.023638Z] Finished install step (success) 10:16:46 INFO - [mozharness: 2016-09-01 17:16:46.023920Z] Running run-tests step. 10:16:46 INFO - Running pre-action listener: _resource_record_pre_action 10:16:46 INFO - Running main action method: run_tests 10:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:46 INFO - Python 2.7.3 10:16:46 INFO - Return code: 0 10:16:46 INFO - grabbing minidump binary from tooltool 10:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:46 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 0x2a1b090>, '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 0x2a1e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:46 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 10:16:46 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 10:16:46 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 10:16:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:46 INFO - Return code: 0 10:16:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 10:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 10:16:46 INFO - Using env: {'DISPLAY': ':0', 10:16:46 INFO - 'HOME': '/home/cltbld', 10:16:46 INFO - 'LANG': 'en_US.UTF-8', 10:16:46 INFO - 'LANGUAGE': 'en_US:en', 10:16:46 INFO - 'LOGNAME': 'cltbld', 10:16:46 INFO - 'MAIL': '/var/mail/cltbld', 10:16:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:46 INFO - 'MOZ_NO_REMOTE': '1', 10:16:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:46 INFO - 'NO_EM_RESTART': '1', 10:16:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:46 INFO - 'PWD': '/builds/slave/test', 10:16:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:46 INFO - 'SHELL': '/bin/bash', 10:16:46 INFO - 'SHLVL': '1', 10:16:46 INFO - 'TERM': 'linux', 10:16:46 INFO - 'TMOUT': '86400', 10:16:46 INFO - 'USER': 'cltbld', 10:16:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697', 10:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:46 INFO - '_': '/tools/buildbot/bin/python'} 10:16:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 10:16:46 INFO - mozversion application_buildid: 20160901083921 10:16:46 INFO - mozversion application_changeset: 737088027e6823ba0206d83735a185f80a89bd77 10:16:46 INFO - mozversion application_display_name: Nightly 10:16:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:46 INFO - mozversion application_name: Firefox 10:16:46 INFO - mozversion application_remotingname: firefox 10:16:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:16:46 INFO - mozversion application_vendor: Mozilla 10:16:46 INFO - mozversion application_version: 51.0a1 10:16:46 INFO - mozversion platform_buildid: 20160901083921 10:16:46 INFO - mozversion platform_changeset: 737088027e6823ba0206d83735a185f80a89bd77 10:16:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:16:46 INFO - mozversion platform_version: 51.0a1 10:16:46 INFO - using testdate: 1472750206 10:16:46 INFO - actual date: 1472750206 10:16:46 INFO - starting webserver on 'localhost:52371' 10:16:46 INFO - SUITE-START | Running 2 tests 10:16:46 INFO - TEST-START | dromaeo_css 10:16:46 INFO - operating with platform_type : linux_ 10:16:46 INFO - Initialising browser for dromaeo_css test... 10:16:46 INFO - TEST-INFO | started process 24101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMFQ_A/profile http://localhost:52371/getInfo.html) 10:16:51 INFO - PROCESS | 24101 | __metrics Screen width/height:1600/1200 10:16:51 INFO - PROCESS | 24101 | colorDepth:24 10:16:51 INFO - PROCESS | 24101 | Browser inner width/height: 1024/697 10:16:51 INFO - PROCESS | 24101 | __metrics 10:16:51 INFO - PROCESS | 24101 | 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" 10:16:51 INFO - PROCESS | 24101 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:52 INFO - PROCESS | 24101 | console.error: PushService: 10:16:52 INFO - PROCESS | 24101 | stateChangeProcessEnqueue: Error transitioning state 10:16:52 INFO - PROCESS | 24101 | UnknownError 10:16:52 INFO - TEST-INFO | 24101: exit 0 10:16:52 INFO - Browser initialized. 10:16:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:52 INFO - TEST-INFO | started process 24181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMFQ_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:05 INFO - PROCESS | 24181 | RSS: Main: 182239232 10:17:05 INFO - PROCESS | 24181 | 10:17:56 INFO - PROCESS | 24181 | 1472750276704 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] 10:20:09 INFO - PROCESS | 24181 | Cycle 1(1): loaded http://localhost:52371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52371/tests/dromaeo/cssquery-ext.html) 10:20:10 INFO - PROCESS | 24181 | RSS: Main: 288256000 10:20:10 INFO - PROCESS | 24181 | 10:23:13 INFO - PROCESS | 24181 | Cycle 1(1): loaded http://localhost:52371/tests/dromaeo/cssquery-ext.html (next: http://localhost:52371/tests/dromaeo/cssquery-jquery.html) 10:23:14 INFO - PROCESS | 24181 | RSS: Main: 280813568 10:23:14 INFO - PROCESS | 24181 | 10:26:16 INFO - PROCESS | 24181 | Cycle 1(1): loaded http://localhost:52371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52371/tests/dromaeo/cssquery-mootools.html) 10:26:17 INFO - PROCESS | 24181 | RSS: Main: 218615808 10:26:17 INFO - PROCESS | 24181 | 10:29:19 INFO - PROCESS | 24181 | Cycle 1(1): loaded http://localhost:52371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52371/tests/dromaeo/cssquery-prototype.html) 10:29:19 INFO - PROCESS | 24181 | RSS: Main: 219029504 10:29:19 INFO - PROCESS | 24181 | 10:32:23 INFO - PROCESS | 24181 | Cycle 1(1): loaded http://localhost:52371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52371/tests/dromaeo/cssquery-yui.html) 10:32:23 INFO - PROCESS | 24181 | RSS: Main: 219140096 10:32:23 INFO - PROCESS | 24181 | 10:35:26 INFO - PROCESS | 24181 | Cycle 1(1): loaded http://localhost:52371/tests/dromaeo/cssquery-yui.html (next: http://localhost:52371/tests/dromaeo/cssquery-dojo.html) 10:35:27 INFO - PROCESS | 24181 | RSS: Main: 310173696 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | __start_tp_report 10:35:27 INFO - PROCESS | 24181 | _x_x_mozilla_page_load 10:35:27 INFO - PROCESS | 24181 | _x_x_mozilla_page_load_details 10:35:27 INFO - PROCESS | 24181 | |i|pagename|runs| 10:35:27 INFO - PROCESS | 24181 | |0;dojo.html;2543.38958649924;2566.1788227767124;2575.8454492730425;2581.019212699174;2596.857172855492;4534.093181363733;4587.357769912211;4599.655025873056;4613.261878099501;4646.047560250149;4648.581627653519;4687.835925742591;4730.4559975602815;4746.193147164981;4817.759112044392;4228.640565551932;4303.935440968388;4321.58944900234;4325.805338759747;4453.487848897385;4378.562143785628;4388.626966707834;4390.2536568783225;4390.978045109786;4423.049044455442;4174.91650166995;4211.810468528924;4224.38746381776;4307.6769242306955;4387.232234359007;4280.871573852789;4285.185814695229;4286.121345124273;4286.849960251377;4287.742735435852;4233.936490952638;4240.9151816963795;4274.764887931163;4279.33670281107;4340.197063543223;4622.560856718606;4628.976855115703;4629.583337499641;4684.718916864965;4696.178168820443;4995.050940321364;5006.299118123466;5009.223570346602;5014.648974571782;5065.772040258197;4866.902661946777;4903.509649035103;4941.036497882914;5033.572146367563;5097.5667068299235;4623.53764623535;4626.306054091846;4627.074585082997;4680.648951328664;4685.390899183084;5021.799128034838;5046.6719663221775;5061.5950723942;5061.645684802103;5099.745012749348;4658.953410465852;4829.903401932012;4889.682170658896;4969.90060198794;4973.229149481836;5073.771680274396;5073.822416215488;5077.746112694351;5103.234514822806;5134.666246694028;4879.609631229493;4891.63312751538;4894.755262236945;4895.0209958008545;4955.430125535538;4782.5456581625385;4878.195097808822;4879.902401951941;4888.144574699413;4939.53074457926;4258.276093064186;4276.102018576072;4287.421198138274;4336.956630433719;4338.154059958278;3697.5378077740284;3698.7965661888857;3699.8335074921692;3736.7010639148803;3749.643783840531;4202.768847713344;4253.723507971972;4293.677974151951;4302.483701955785;4343.69594128408;4962.305277261186;5003.399592048904;5026.220935754964;5026.773795179226;5073.543381095719;4295.5489673583825;4328.069465064963;4331;4334.349847522897;4379.430674012358;4388.144311859221;4542.409486766765;4545.977155140067;4552.453705555288;4599;4670.78981445829;4671.602913752369;4675.392199014106;4693.812247510062;4761.952380476151;4939.135651261086;4950.133726597759;4951.529604687549;4962.776675049559;5013.122703526941;4598.517155698603;4653.092646933816;4681.368015317888;4703.247480403119;4759.286107083965;4808.903821923612;4855.781489833037;4873.366462359871;4877.756112194305;4878.365812444502;4942.332785073969;4999.175136102648;5011.373578302712;5013.197888337849;5080.568151707146;4853.9029219416125;4872.415310162662;4879.682820616648;4882.072406242944;4940.382452193476;4726.763661816826;4872.780724867319;4876.853694389174;4883.4783303136255;4937.654364194472;4666.929996049994;4735.005648813788;4770.952290477189;4786.856394308176;4861.4895435978715;4971.9502804972935;4982.377202849644;4984.651074424755;5023.572996295356;5047.116754568009;4757.35775670294;4848.927266091082;4863.148948933852;4868.926966095582;4923.5814955729165 10:35:27 INFO - PROCESS | 24181 | |1;ext.html;569.7350731909662;573.7848306884919;580.6429046136627;588.3498733899041;591.9348871624122;27531.862340688294;37688.05779855502;38700.612993870054;38714.80642596783;42345.78827105868;39158;39576.80211598945;39622.207555848865;39653.40519892204;39674.60325396752;7658.2724641159275;7810.1408845027;7814.179511151333;7814.413918956073;7819.648115834772;7190.316919892628;9768.804623907517;10055.296129270953;10065.245106616996;10404.271700980935;10039;10168.44073575953;10170.847437288447;10171.898281017206;10182.64360747374;10034.498275086253;10097.040781125856;10098.646547370843;10101.494925253708;10111.544980475895;9803.215742740564;9877.259205559612;9883.703488895344;9885.851712224323;9893.406395616286;36401.45397819035;36670.266594668225;36783;36784;36817.815910920544;2805.7895657825743;2897.377063931244;3273.453885553068;3379.3072420154053;3686.576043754949;27723.168304950883;28145.859270703517;28379.432411351656;28413.573796392862;28428;3451.4650229214512;3554.129238336598;3560.483729859182;3571.196480791827;3607.116256517144;251761;254100;254347;254507;255270;49223.507764921895;49428.50571494239;49450.75274623604;49498;49622.50377496251;32320.191995200308;33561.83219083889;33626;33636.32727345488;33646.831765841016;15294.617634559225;15460.304286306919;15464;15470.226488675522;15479.613009674624;10521.316114452537;10780.35317880914;11703.648890533297;11785;11856.466459009365;15424.845751542342;15542.300596473186;16747.729329021022;17409;17478;6579.934200658028;6640.667966601651;6665.600063996176;6671.766488172891;6882.208546017172;748.8015675845905;775.6276987046249;785.9331956783623;892.5715656484793;928.7399528132133;25846;26597.601035984477;27641.308967275978;28174.43651126966;28504.28739281493;933.5005771911995;949.8432758594754;958.2956526952685;1012.3268026762121;1016.3698506925606;14545.490907818175;14810;14824.110553366832;14845.554633361016;14944.70110597782;373606;378021;378393;378868;380485;49126;49673.75163124233;49695.25457118146;49788.25317620239;49792.25311620328;1130.2032067392634;1145.725025993772;1186.875378085323;1190.892819646236;1191.231655582162;25701.61447578325;26091.608625871006;27297.454050918474;27784.583231251952;27829.860850695615;42716;43350.93086967764;43443.782781085894;43458.78270608627;43465.78267108644;354611;356822;357000;357265;357805;29098.854505727337;31085.844570777;32274;37711.62288377191;38410;34910.65089349074;35025;40082.39876401798;40648.79675601603;41589.79205103955;31855.681443185273;33797;34900.301993959474;35438.82280588581;35749;34183;34246.828765857004;34714.82642586872;34832.82583587066;34992.65007349894;34115.82942085274;34255.31489370248;34263.65736342605;34506.65493345135;35041;27588.586171207047;29496;30450.390992180477;31422.842885785423;32558;24420.75579244256;24738.628920566567;24798.38004049913;24904.377390564656;24984.37539061538 10:35:27 INFO - PROCESS | 24181 | |2;jquery.html;341.95191737325115;360.18238598381674;367.1390589068634;369.95745489268734;390.7089218532194;12343.691407714812;14222.786658200135;16011.599710007256;16027.759583606241;16056;15638.687226255497;15883.841161588382;16079;16147.515574532754;16873.40943066993;4341.826326946918;5070.518300761421;5096.159133742946;5104.055749686301;5106;3373.1398493384154;3568.1614820517157;4909.116359055369;4979.253112033188;4980.352554167953;3608.566971963368;3717.2379662169324;5762.884742305151;5771.797987070453;5870.090136028923;5728.25532680753;5850.795222167247;5853.414658534134;5860.033094539439;5867.325257595388;5144.4083930348115;5184.144616138333;5199.714015729133;5205.219217117425;5206.5314121729225;12432.564860229848;12480.126391152622;12506.937465312707;20148.899255503628;20285.188592456285;1836.8703247502824;1842.7880793708628;1893.1480833624787;1951.4926119208965;2076.5535409886797;8934.329925255632;9082.954585227031;9129.315301352424;9266.397684150508;9619.134277915022;1733.16807932192;1747.405882000126;1752.6582316448298;1753.158483927709;1789.6152327249574;49347.753261233825;62063.689681551754;63476.36523634797;66468;69915.65042174807;9858.654947076819;9900.603975840886;10341.74145646365;10404.479776011169;10535.683929482127;13752.793708094387;13814.723705525834;13818.861811381757;13831.446742130202;13851;7056.964715176391;7112.57324560528;7131.0373099631925;7208.2791720828545;7463.477556570988;6573.474122070223;6611.578510620144;6804.4216241620015;6814.011968264574;6826.488013399015;4052.371882358239;4187.539370669224;4328.696991210648;4352.347147927836;4455.888602784957;1718.3813827022261;1772.2556526259002;1826.5159732670588;1861.500379286932;1887.160213704888;798.7044793426469;812.7277362083768;813.9837203255902;817.4727300890892;828.1842385250524;16268.918655406647;16285.185740712917;16503.587410314598;16664.666706665797;17368.218430170673;806.0810675829559;816.1715858403725;837.6398148795954;844.3793811548506;871.808202195516;9113.179813816789;9314.161725444606;9374.953125234466;9431.386959847589;9697.321187516947;371040;373171;390662;392465;392828;78515;78887.60556197182;81133.59433202914;81459;83529;889.4974339498162;892.1034360467688;925.3430064654036;948.9145976862116;950.805084957582;13862;13906.652333691738;13986.580402587939;14022.439102435788;14789.926050369679;37794.8110259458;39172;39376.803115985385;40143.598564015156;40417.39373909453;51610.74194629003;52804.73597631987;53284;53354.46645533495;53541;7388.298111679382;7630.2751238632245;7692.8461430772195;7710.7686769397005;7830.765077047698;8716.738497845075;11460.426978650867;11805.409729513662;11829.76340473203;12067.637970860887;9911;10184.287099903231;10298.845517317395;10498.737531561772;10751.784964300514;10067.29528932997;10078.395296282246;10111.64609238673;10140.188784897044;10344.793104138025;9684.757881052748;9938;10112.49437528106;10192.694219173436;10611.787764244826;7439.8140046499275;7475.476716629783;7637.083549974039;7712.074551053909;8074.919250807417;8760.853590870278;9798.167155791838;9973.351732137678;10178.949105254722;10572.89427105719 10:35:27 INFO - PROCESS | 24181 | |3;mootools.html;1250.3873102179932;1292.5088466382774;1303.9828933431922;1622.7160246956787;1626.3494602159128;6626.668666566665;7246.130464344279;7362;7798.3761299096;7800.219978002204;7429.331360177583;7704.653290601922;7715.922840771591;7726.8840967385395;7736.845263094749;2140.8715477071346;2172.0985790896757;2172.3048624440185;2173.445771328309;2174.9782502174935;1798.0829776813853;2045.795420457957;2088.853780235384;2112.6197284488785;2118.629239883022;2147.602693501707;2169.4684802223396;2170.251263314154;2171.522265101675;2171.869687818736;2073.5852829434098;2122.9363119106374;2151.257816053459;2151.580441813847;2155.611989841828;2088.6136064828056;2101.53766171442;2108.7996640319143;2114.027547328231;2137.444264491228;7682.116556596007;7761.650725717356;7767.223277672244;7776.805579860492;7784.182660820646;4279.293916503773;4410.492793328776;4415.911681766347;4416.867493975154;4417.712848664826;2765.847878366689;2843.8720257588457;2895.7104289571084;2925.18094933419;2936.6329208848892;906.3338446242007;933.8365785987424;959.9088086631759;965.6330594374093;970.8689326940843;10327.58689652413;10338.7415314617;10349.58601655933;10358.274920755475;10378.9481052595;3761.4921985531605;4006.419069234945;4177.12280421115;4187.853425130106;4195.139996300751;8883.866741998876;8886.066962968795;8902.955485222532;8909.331800115016;8911.955440222757;4501.954980450219;4505.166544189336;4505.346724724896;4517.706349087299;4525.389072475239;4085.550589435219;4135.503739551213;4144.689148313889;4157.189348077157;4164.5210800757695;3565.607783143852;3643.5081264029545;3659.0486473516544;3685.336639404933;3716.0524066362905;1063.3619828103076;1161.9070474362031;1165.877582853805;1196.6170825335982;1204.801207800703;817.5708445922558;820.9466384684977;832.0556168748393;844.0883845447025;845.2308399356679;5215.843524694265;5464.426235245322;5487.6981766002455;5700.543956483471;5716.857078572986;799.9720009799629;836.4479443567338;840.1556435781999;854.1714536899322;901.3014913442134;3588.246468241646;3666.633336666312;3667.614900435416;3693.464447655129;3743.457198706172;9101.226395756436;9459.858102128474;9678.080582344666;9678.128968392879;9712.660056897974;9541.522923853918;9609.183219426428;9625.71122866315;9636.132748052569;9647.421154730599;7075.327843854826;7093.964530177316;7180.9640951795955;7207.783766487014;7213.963930180421;5055.064813009605;5080.593552515864;5153.4073581538605;5247.2129180623215;5363.302770639792;8685.39202255836;8776.736697899074;8843.275561265491;8915.598798053974;8957.28341732673;8869.290456763314;8929.374943753875;9009.414388064755;9011.188992990663;9088;6304.779332723516;6418.229812422539;6423.775167869289;6430.099786029866;6430.5177111715875;6961.79114626562;7018.087648605649;7111.679974401268;7261.092363454568;7321.707131714672;5422.942526207509;6353.4599559038;6373.968130159319;6538.1500404947055;6708.798736037927;6415.615063096229;6440.484761219185;6441.291457939717;6461.1600491937625;6472.967635161983;6109.327973922776;6240.251169859646;6248.718807653576;6272.780452684134;6277.686115694106;4483.30508771141;4499.77501124949;4501.6848820582245;4538.455385353779;4575.862724118282;4321.243782338015;4399.516053234078;4437.134758722018;4444.377787109743;4465.419495465569 10:35:27 INFO - PROCESS | 24181 | |4;prototype.html;298.0923089193406;300.1805072153022;306.2726025688989;309.1452134847148;310.02188096555375;4815.771978145573;4836.854894353166;4852.403963879326;4867.829625963092;4884.853454396365;4776.355192049073;4783.330333753269;4812.879678008052;4816.133096042711;4823.9758801206035;3574.5531808523933;3608.260306637146;3725.1990821973272;3738.3644780387262;3754.8498060077563;3734.2904848078915;3736.514253147087;3749.568799588055;3751.3060083884434;3769.6795772359383;3710.2208536207295;3711.294853977736;3712.5916149223563;3729.552453705559;3744.7191460640424;3545.92908141837;3591.317649646559;3710.5361829771277;3729.5710993235853;3759.3984962405884;3288.7369010479106;3297.653746356622;3306.487494438366;3309;3317.8672853085845;4628.54200926707;4633.6061434778085;4642.816081899128;4647.744374059425;4697.3893393858925;4146.543880173179;4268.637165840907;4274.914501709979;4284.400183974246;4289.297742422285;4910.459849416561;4939.407271127452;4959.305697202394;4976.377952755905;4997.325361076245;3599.94600080999;3605.47720580517;3609.3864043112735;3657.6159503252043;3663.835127419246;4934.358533390637;5198.634621247361;5242.344706911636;5250.7112108834;5260.815871444481;3568.982155089208;3584.444411116281;3586.193106551057;3586.8385922633543;3617.9276414471565;3612.164450906079;3622.800745958945;3625.274945011008;3648.927021459556;3652.3243200008083;4178.35235538492;4186.597489840938;4186.874393768192;4201.411802347674;4228.746275223435;4836.3712717347225;4964.205727083649;4965.950340496549;5070.366204224472;5071.847844564669;1251.330538162079;1255.2656695832857;1262.3435813376993;1262.4319056424463;1263.4693428759942;776.4099284543674;792.9563873986987;802.827392110699;804.8470790549777;805.2269820971933;4213.557576454489;4267.765272909957;4463.991203958231;4471.5081341052455;4494.483134439516;5080.974595127001;5104.3619547556555;5110.437851836295;5150.27896094547;5174.379074511007;4423.407573273619;4430.139341476588;4434.733915965053;4439.246497633417;4453.265211240174;2617.816752827284;2657.6677915260593;2705.269577214141;2714.538528450168;2734.1387462949106;4854.441739199967;4859.2954021666665;4897.681650692693;4900.313956046157;4919.901601968012;5056.620753443506;5250.527452529291;5256.737163141904;5266.78932842682;5275.522853600921;4851.223804191383;4864.562189402971;4878.878028049327;4898.583620392164;4922.507749225048;5119.97600479898;5130.51260130287;5134.5635620972635;5163.66436181647;5170.879939224899;4744.667873248839;5030.5975521957425;5059.19052951526;5068;5086.54221120101;4792.3530323407285;4823.1800593898415;4827.493113223061;4843.975780121077;4862.756862156949;3602.5496812898386;3644.143626247883;3655.2324011957785;3679.3377192105677;3682.447632854986;5108.821191258288;5143.048536020848;5156.793728250828;5210.687358758487;5211.687298762086;4737.715737055788;5013;5016.147254966738;5033.622478314068;5052.722100284373;4992.2761199626575;5002.474740152232;5003.174476211384;5031.6226283029655;5032.798688052437;4765.925977744266;4917.926231106465;4920.892799120169;4947.703137811743;4951.801927922843;4804.711717296974;4918.188498897642;5038.211434940544;5042.546170844642;5099.413567439792;4918.213085906238;4943.233798761198;4945.727984960861;4950.282209079735;4953.900921981613 10:35:27 INFO - PROCESS | 24181 | |5;yui.html;541.9485148910853;598;609.7560975609758;620.3889169168368;621.947134493568;11464;12377.381130943462;12380.81428778569;12392.690182745424;12897.935510322435;13400.731985360288;13985.440582376717;14053;14053.92973035136;14096.295185240722;730.0509337860786;754.3022703998806;755.9697612095509;756.8599809035346;757.23141011873;600.7026521871679;718.2279050021222;749.6064566102785;751.7669522448032;754.1139161485261;792.0376742258155;793.972210972616;794.0392125528118;794.3605397654885;794.6503538443095;788.4874831359662;788.5938741548107;788.6963519045152;788.9368850491946;789.3448437796644;460.0454057830016;550.6998685716294;565.2199964049627;566.0914232656609;577.0997244298907;12032.157748957576;12200.755984880252;12205.596356419037;12229.510819567207;12230.388480575935;11490.36802975836;11781.528738850435;12144.635660930186;12146.514139434412;12408.160832178366;11412.942935285353;11445.25605835618;11463.426828658618;11599.246049006788;11617.477213525328;3930.9017274568077;3966.504186976628;3989.6209860063245;3997.980010099931;4008.4388185654034;66235.3376466234;67315.66342168307;68037.65981170112;68330.65834670844;68567.65716171438;9489.145976862115;9759.609615615438;9858.704238872846;9951.552180151766;10206.285560010729;17323.826761732475;18631.627367452576;18645.50835933122;18665.44003679892;18672.533186670444;6636.8672626547195;6723.865522689519;6808.6936087876165;6825.419839313714;6877.58734475933;3656.561212654445;3747.756395834262;3793.6016718244737;3870.7290489666016;3879.7866117363815;2983.298924752681;3084.0593618946436;3106.502959526465;3106.673799251046;3107.5183346580866;514.4161376837242;532.5384997516145;532.7229840482927;536.9785208591691;553.261396036288;511.1616948204947;527.6174773289334;530.5278302310946;553.9778408863681;588.109014842514;7936.16670249627;7981.800454988672;8210.343172546302;8373.162683731578;8509.916765992364;496.39439883342266;524.1979770950452;568.139269007454;575.7840809696364;582.988340233193;3606.098475381155;3745.0824547985917;3868.7485313454536;3918.9020274493364;3984.907461261936;98719;102043;102597;103281.48359258306;105360;67176.66411667911;68732.65633671799;87611.04861892264;91715.54142229246;91723;65158.999999999054;67848.32151678519;68577;71239;71841;8122.55325957078;8550.957245213734;8593.742187734379;8638.352123590881;8656.350773692124;30438.239044024078;38090.23819523538;38477.2304553913;38578.80710596429;43456.565434345255;59266.44304360608;60243.39756602378;60496.39503605084;60647;60684.393156069644;10604.151667866707;10967.561297548009;11030.87711276889;11365.886341136813;11832.881671183179;11999.76000479968;12586.370681465707;12614.243145411305;12682.936585317015;12894.419751111034;11477;11489.482973266056;11531.481083351437;11694.181407301407;11835.323415169183;9139.817203655757;11147.275427097213;11245.718857028312;11432.657020289405;11703.414829258332;10851.403172825254;11098.056665183227;11113.722156946142;11242.66272011841;11891.821622675494;9729.756756081155;9752.219822414048;9922.751931201778;10201.132903702972;10899.51215610997;9144.359894807565;9819.312648114563;9830.508474576385;9839.704808855746;9866.654667086617 10:35:27 INFO - PROCESS | 24181 | __end_tp_report 10:35:27 INFO - PROCESS | 24181 | __start_cc_report 10:35:27 INFO - PROCESS | 24181 | _x_x_mozilla_cycle_collect,1007 10:35:27 INFO - PROCESS | 24181 | __end_cc_report 10:35:27 INFO - PROCESS | 24181 | __startTimestamp1472751327044__endTimestamp 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | ------- Summary: start ------- 10:35:27 INFO - PROCESS | 24181 | Number of tests: 6 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | [#0] dojo.html Cycles:165 Average:4613.88 Median:4726.76 stddev:482.87 (10.2%) stddev-sans-first:456.21 10:35:27 INFO - PROCESS | 24181 | Values: 2543.4 2566.2 2575.8 2581.0 2596.9 4534.1 4587.4 4599.7 4613.3 4646.0 4648.6 4687.8 4730.5 4746.2 4817.8 4228.6 4303.9 4321.6 4325.8 4453.5 4378.6 4388.6 4390.3 4391.0 4423.0 4174.9 4211.8 4224.4 4307.7 4387.2 4280.9 4285.2 4286.1 4286.8 4287.7 4233.9 4240.9 4274.8 4279.3 4340.2 4622.6 4629.0 4629.6 4684.7 4696.2 4995.1 5006.3 5009.2 5014.6 5065.8 4866.9 4903.5 4941.0 5033.6 5097.6 4623.5 4626.3 4627.1 4680.6 4685.4 5021.8 5046.7 5061.6 5061.6 5099.7 4659.0 4829.9 4889.7 4969.9 4973.2 5073.8 5073.8 5077.7 5103.2 5134.7 4879.6 4891.6 4894.8 4895.0 4955.4 4782.5 4878.2 4879.9 4888.1 4939.5 4258.3 4276.1 4287.4 4337.0 4338.2 3697.5 3698.8 3699.8 3736.7 3749.6 4202.8 4253.7 4293.7 4302.5 4343.7 4962.3 5003.4 5026.2 5026.8 5073.5 4295.5 4328.1 4331.0 4334.3 4379.4 4388.1 4542.4 4546.0 4552.5 4599.0 4670.8 4671.6 4675.4 4693.8 4762.0 4939.1 4950.1 4951.5 4962.8 5013.1 4598.5 4653.1 4681.4 4703.2 4759.3 4808.9 4855.8 4873.4 4877.8 4878.4 4942.3 4999.2 5011.4 5013.2 5080.6 4853.9 4872.4 4879.7 4882.1 4940.4 4726.8 4872.8 4876.9 4883.5 4937.7 4666.9 4735.0 4771.0 4786.9 4861.5 4972.0 4982.4 4984.7 5023.6 5047.1 4757.4 4848.9 4863.1 4868.9 4923.6 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | [#1] ext.html Cycles:180 Average:47585.81 Median:18979.06 stddev:87902.01 (463.2%) stddev-sans-first:88077.72 10:35:27 INFO - PROCESS | 24181 | Values: 569.7 573.8 580.6 588.3 591.9 27531.9 37688.1 38700.6 38714.8 42345.8 39158.0 39576.8 39622.2 39653.4 39674.6 7658.3 7810.1 7814.2 7814.4 7819.6 7190.3 9768.8 10055.3 10065.2 10404.3 10039.0 10168.4 10170.8 10171.9 10182.6 10034.5 10097.0 10098.6 10101.5 10111.5 9803.2 9877.3 9883.7 9885.9 9893.4 36401.5 36670.3 36783.0 36784.0 36817.8 2805.8 2897.4 3273.5 3379.3 3686.6 27723.2 28145.9 28379.4 28413.6 28428.0 3451.5 3554.1 3560.5 3571.2 3607.1 251761.0 254100.0 254347.0 254507.0 255270.0 49223.5 49428.5 49450.8 49498.0 49622.5 32320.2 33561.8 33626.0 33636.3 33646.8 15294.6 15460.3 15464.0 15470.2 15479.6 10521.3 10780.4 11703.6 11785.0 11856.5 15424.8 15542.3 16747.7 17409.0 17478.0 6579.9 6640.7 6665.6 6671.8 6882.2 748.8 775.6 785.9 892.6 928.7 25846.0 26597.6 27641.3 28174.4 28504.3 933.5 949.8 958.3 1012.3 1016.4 14545.5 14810.0 14824.1 14845.6 14944.7 373606.0 378021.0 378393.0 378868.0 380485.0 49126.0 49673.8 49695.3 49788.3 49792.3 1130.2 1145.7 1186.9 1190.9 1191.2 25701.6 26091.6 27297.5 27784.6 27829.9 42716.0 43350.9 43443.8 43458.8 43465.8 354611.0 356822.0 357000.0 357265.0 357805.0 29098.9 31085.8 32274.0 37711.6 38410.0 34910.7 35025.0 40082.4 40648.8 41589.8 31855.7 33797.0 34900.3 35438.8 35749.0 34183.0 34246.8 34714.8 34832.8 34992.7 34115.8 34255.3 34263.7 34506.7 35041.0 27588.6 29496.0 30450.4 31422.8 32558.0 24420.8 24738.6 24798.4 24904.4 24984.4 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | [#2] jquery.html Cycles:180 Average:23835.99 Median:4682.50 stddev:63535.30 (1356.9%) stddev-sans-first:63689.05 10:35:27 INFO - PROCESS | 24181 | Values: 342.0 360.2 367.1 370.0 390.7 12343.7 14222.8 16011.6 16027.8 16056.0 15638.7 15883.8 16079.0 16147.5 16873.4 4341.8 5070.5 5096.2 5104.1 5106.0 3373.1 3568.2 4909.1 4979.3 4980.4 3608.6 3717.2 5762.9 5771.8 5870.1 5728.3 5850.8 5853.4 5860.0 5867.3 5144.4 5184.1 5199.7 5205.2 5206.5 12432.6 12480.1 12506.9 20148.9 20285.2 1836.9 1842.8 1893.1 1951.5 2076.6 8934.3 9083.0 9129.3 9266.4 9619.1 1733.2 1747.4 1752.7 1753.2 1789.6 49347.8 62063.7 63476.4 66468.0 69915.7 9858.7 9900.6 10341.7 10404.5 10535.7 13752.8 13814.7 13818.9 13831.4 13851.0 7057.0 7112.6 7131.0 7208.3 7463.5 6573.5 6611.6 6804.4 6814.0 6826.5 4052.4 4187.5 4328.7 4352.3 4455.9 1718.4 1772.3 1826.5 1861.5 1887.2 798.7 812.7 814.0 817.5 828.2 16268.9 16285.2 16503.6 16664.7 17368.2 806.1 816.2 837.6 844.4 871.8 9113.2 9314.2 9375.0 9431.4 9697.3 371040.0 373171.0 390662.0 392465.0 392828.0 78515.0 78887.6 81133.6 81459.0 83529.0 889.5 892.1 925.3 948.9 950.8 13862.0 13906.7 13986.6 14022.4 14789.9 37794.8 39172.0 39376.8 40143.6 40417.4 51610.7 52804.7 53284.0 53354.5 53541.0 7388.3 7630.3 7692.8 7710.8 7830.8 8716.7 11460.4 11805.4 11829.8 12067.6 9911.0 10184.3 10298.8 10498.7 10751.8 10067.3 10078.4 10111.6 10140.2 10344.8 9684.8 9938.0 10112.5 10192.7 10611.8 7439.8 7475.5 7637.1 7712.1 8074.9 8760.9 9798.2 9973.4 10178.9 10572.9 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | [#3] mootools.html Cycles:180 Average:5038.24 Median:5393.12 stddev:2820.00 (52.3%) stddev-sans-first:2813.54 10:35:27 INFO - PROCESS | 24181 | Values: 1250.4 1292.5 1304.0 1622.7 1626.3 6626.7 7246.1 7362.0 7798.4 7800.2 7429.3 7704.7 7715.9 7726.9 7736.8 2140.9 2172.1 2172.3 2173.4 2175.0 1798.1 2045.8 2088.9 2112.6 2118.6 2147.6 2169.5 2170.3 2171.5 2171.9 2073.6 2122.9 2151.3 2151.6 2155.6 2088.6 2101.5 2108.8 2114.0 2137.4 7682.1 7761.7 7767.2 7776.8 7784.2 4279.3 4410.5 4415.9 4416.9 4417.7 2765.8 2843.9 2895.7 2925.2 2936.6 906.3 933.8 959.9 965.6 970.9 10327.6 10338.7 10349.6 10358.3 10378.9 3761.5 4006.4 4177.1 4187.9 4195.1 8883.9 8886.1 8903.0 8909.3 8912.0 4502.0 4505.2 4505.3 4517.7 4525.4 4085.6 4135.5 4144.7 4157.2 4164.5 3565.6 3643.5 3659.0 3685.3 3716.1 1063.4 1161.9 1165.9 1196.6 1204.8 817.6 820.9 832.1 844.1 845.2 5215.8 5464.4 5487.7 5700.5 5716.9 800.0 836.4 840.2 854.2 901.3 3588.2 3666.6 3667.6 3693.5 3743.5 9101.2 9459.9 9678.1 9678.1 9712.7 9541.5 9609.2 9625.7 9636.1 9647.4 7075.3 7094.0 7181.0 7207.8 7214.0 5055.1 5080.6 5153.4 5247.2 5363.3 8685.4 8776.7 8843.3 8915.6 8957.3 8869.3 8929.4 9009.4 9011.2 9088.0 6304.8 6418.2 6423.8 6430.1 6430.5 6961.8 7018.1 7111.7 7261.1 7321.7 5422.9 6353.5 6374.0 6538.2 6708.8 6415.6 6440.5 6441.3 6461.2 6473.0 6109.3 6240.3 6248.7 6272.8 6277.7 4483.3 4499.8 4501.7 4538.5 4575.9 4321.2 4399.5 4437.1 4444.4 4465.4 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | [#4] prototype.html Cycles:180 Average:4150.43 Median:4798.53 stddev:1212.83 (25.3%) stddev-sans-first:1181.26 10:35:27 INFO - PROCESS | 24181 | Values: 298.1 300.2 306.3 309.1 310.0 4815.8 4836.9 4852.4 4867.8 4884.9 4776.4 4783.3 4812.9 4816.1 4824.0 3574.6 3608.3 3725.2 3738.4 3754.8 3734.3 3736.5 3749.6 3751.3 3769.7 3710.2 3711.3 3712.6 3729.6 3744.7 3545.9 3591.3 3710.5 3729.6 3759.4 3288.7 3297.7 3306.5 3309.0 3317.9 4628.5 4633.6 4642.8 4647.7 4697.4 4146.5 4268.6 4274.9 4284.4 4289.3 4910.5 4939.4 4959.3 4976.4 4997.3 3599.9 3605.5 3609.4 3657.6 3663.8 4934.4 5198.6 5242.3 5250.7 5260.8 3569.0 3584.4 3586.2 3586.8 3617.9 3612.2 3622.8 3625.3 3648.9 3652.3 4178.4 4186.6 4186.9 4201.4 4228.7 4836.4 4964.2 4966.0 5070.4 5071.8 1251.3 1255.3 1262.3 1262.4 1263.5 776.4 793.0 802.8 804.8 805.2 4213.6 4267.8 4464.0 4471.5 4494.5 5081.0 5104.4 5110.4 5150.3 5174.4 4423.4 4430.1 4434.7 4439.2 4453.3 2617.8 2657.7 2705.3 2714.5 2734.1 4854.4 4859.3 4897.7 4900.3 4919.9 5056.6 5250.5 5256.7 5266.8 5275.5 4851.2 4864.6 4878.9 4898.6 4922.5 5120.0 5130.5 5134.6 5163.7 5170.9 4744.7 5030.6 5059.2 5068.0 5086.5 4792.4 4823.2 4827.5 4844.0 4862.8 3602.5 3644.1 3655.2 3679.3 3682.4 5108.8 5143.0 5156.8 5210.7 5211.7 4737.7 5013.0 5016.1 5033.6 5052.7 4992.3 5002.5 5003.2 5031.6 5032.8 4765.9 4917.9 4920.9 4947.7 4951.8 4804.7 4918.2 5038.2 5042.5 5099.4 4918.2 4943.2 4945.7 4950.3 4953.9 10:35:27 INFO - PROCESS | 24181 | 10:35:27 INFO - PROCESS | 24181 | [#5] yui.html Cycles:180 Average:17497.58 Median:525.91 stddev:25317.28 (4814.0%) stddev-sans-first:25356.29 10:35:27 INFO - PROCESS | 24181 | Values: 541.9 598.0 609.8 620.4 621.9 11464.0 12377.4 12380.8 12392.7 12897.9 13400.7 13985.4 14053.0 14053.9 14096.3 730.1 754.3 756.0 756.9 757.2 600.7 718.2 749.6 751.8 754.1 792.0 794.0 794.0 794.4 794.7 788.5 788.6 788.7 788.9 789.3 460.0 550.7 565.2 566.1 577.1 12032.2 12200.8 12205.6 12229.5 12230.4 11490.4 11781.5 12144.6 12146.5 12408.2 11412.9 11445.3 11463.4 11599.2 11617.5 3930.9 3966.5 3989.6 3998.0 4008.4 66235.3 67315.7 68037.7 68330.7 68567.7 9489.1 9759.6 9858.7 9951.6 10206.3 17323.8 18631.6 18645.5 18665.4 18672.5 6636.9 6723.9 6808.7 6825.4 6877.6 3656.6 3747.8 3793.6 3870.7 3879.8 2983.3 3084.1 3106.5 3106.7 3107.5 514.4 532.5 532.7 537.0 553.3 511.2 527.6 530.5 554.0 588.1 7936.2 7981.8 8210.3 8373.2 8509.9 496.4 524.2 568.1 575.8 583.0 3606.1 3745.1 3868.7 3918.9 3984.9 98719.0 102043.0 102597.0 103281.5 105360.0 67176.7 68732.7 87611.0 91715.5 91723.0 65159.0 67848.3 68577.0 71239.0 71841.0 8122.6 8551.0 8593.7 8638.4 8656.4 30438.2 38090.2 38477.2 38578.8 43456.6 59266.4 60243.4 60496.4 60647.0 60684.4 10604.2 10967.6 11030.9 11365.9 11832.9 11999.8 12586.4 12614.2 12682.9 12894.4 11477.0 11489.5 11531.5 11694.2 11835.3 9139.8 11147.3 11245.7 11432.7 11703.4 10851.4 11098.1 11113.7 11242.7 11891.8 9729.8 9752.2 9922.8 10201.1 10899.5 9144.4 9819.3 9830.5 9839.7 9866.7 10:35:27 INFO - PROCESS | 24181 | -------- Summary: end -------- 10:35:27 INFO - PROCESS | 24181 | 10:35:28 INFO - TEST-INFO | 24181: exit 0 10:35:28 INFO - TEST-OK | dromaeo_css | took 1121753ms 10:35:28 INFO - TEST-START | kraken 10:35:28 INFO - operating with platform_type : linux_ 10:35:28 INFO - Initialising browser for kraken test... 10:35:28 INFO - TEST-INFO | started process 24488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8s6BOJ/profile http://localhost:52371/getInfo.html) 10:35:32 INFO - PROCESS | 24488 | __metrics Screen width/height:1600/1200 10:35:32 INFO - PROCESS | 24488 | colorDepth:24 10:35:32 INFO - PROCESS | 24488 | Browser inner width/height: 1024/697 10:35:32 INFO - PROCESS | 24488 | __metrics 10:35:33 INFO - PROCESS | 24488 | 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" 10:35:33 INFO - PROCESS | 24488 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:33 INFO - PROCESS | 24488 | console.error: PushService: 10:35:33 INFO - PROCESS | 24488 | stateChangeProcessEnqueue: Error transitioning state 10:35:33 INFO - PROCESS | 24488 | UnknownError 10:35:34 INFO - TEST-INFO | 24488: exit 0 10:35:34 INFO - Browser initialized. 10:35:34 INFO - Running cycle 1/1 for kraken test... 10:35:34 INFO - TEST-INFO | started process 24567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8s6BOJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:46 INFO - PROCESS | 24567 | RSS: Main: 182403072 10:35:46 INFO - PROCESS | 24567 | 10:35:49 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52371/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:50 INFO - PROCESS | 24567 | RSS: Main: 235540480 10:35:50 INFO - PROCESS | 24567 | 10:35:53 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52371/tests/kraken/driver.html?testName=audio-dft) 10:35:53 INFO - PROCESS | 24567 | RSS: Main: 225857536 10:35:53 INFO - PROCESS | 24567 | 10:35:57 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52371/tests/kraken/driver.html?testName=audio-fft) 10:35:57 INFO - PROCESS | 24567 | RSS: Main: 302632960 10:35:57 INFO - PROCESS | 24567 | 10:35:59 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52371/tests/kraken/driver.html?testName=audio-oscillator) 10:36:00 INFO - PROCESS | 24567 | RSS: Main: 212766720 10:36:00 INFO - PROCESS | 24567 | 10:36:02 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:36:03 INFO - PROCESS | 24567 | RSS: Main: 214982656 10:36:03 INFO - PROCESS | 24567 | 10:36:06 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52371/tests/kraken/driver.html?testName=imaging-darkroom) 10:36:07 INFO - PROCESS | 24567 | RSS: Main: 253476864 10:36:07 INFO - PROCESS | 24567 | 10:36:10 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52371/tests/kraken/driver.html?testName=imaging-desaturate) 10:36:11 INFO - PROCESS | 24567 | RSS: Main: 247320576 10:36:11 INFO - PROCESS | 24567 | 10:36:14 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52371/tests/kraken/driver.html?testName=json-parse-financial) 10:36:14 INFO - PROCESS | 24567 | RSS: Main: 250691584 10:36:14 INFO - PROCESS | 24567 | 10:36:16 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:36:17 INFO - PROCESS | 24567 | RSS: Main: 214323200 10:36:17 INFO - PROCESS | 24567 | 10:36:18 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:19 INFO - PROCESS | 24567 | RSS: Main: 221839360 10:36:19 INFO - PROCESS | 24567 | 10:36:21 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:22 INFO - PROCESS | 24567 | RSS: Main: 223174656 10:36:22 INFO - PROCESS | 24567 | 10:36:25 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:25 INFO - PROCESS | 24567 | RSS: Main: 224497664 10:36:25 INFO - PROCESS | 24567 | 10:36:28 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:29 INFO - PROCESS | 24567 | RSS: Main: 221368320 10:36:29 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | Cycle 1(1): loaded http://localhost:52371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52371/tests/kraken/driver.html?testName=ai-astar) 10:36:31 INFO - PROCESS | 24567 | RSS: Main: 273027072 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | __start_tp_report 10:36:31 INFO - PROCESS | 24567 | _x_x_mozilla_page_load 10:36:31 INFO - PROCESS | 24567 | _x_x_mozilla_page_load_details 10:36:31 INFO - PROCESS | 24567 | |i|pagename|runs| 10:36:31 INFO - PROCESS | 24567 | |0;ai-astar;116;115;133;116;114;114;113;115;114;112 10:36:31 INFO - PROCESS | 24567 | |1;audio-beat-detection;152;125;149;185;129;148;160;129;183;122 10:36:31 INFO - PROCESS | 24567 | |2;audio-dft;162;163;164;161;163;162;160;163;160;159 10:36:31 INFO - PROCESS | 24567 | |3;audio-fft;76;74;75;177;75;76;76;76;164;78 10:36:31 INFO - PROCESS | 24567 | |4;audio-oscillator;84;83;147;83;84;83;138;83;84;130 10:36:31 INFO - PROCESS | 24567 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;117;117;118 10:36:31 INFO - PROCESS | 24567 | |6;imaging-darkroom;148;147;148;147;147;147;148;147;147;148 10:36:31 INFO - PROCESS | 24567 | |7;imaging-desaturate;96;95;96;96;95;96;96;96;95;96 10:36:31 INFO - PROCESS | 24567 | |8;json-parse-financial;77;66;67;68;66;66;67;67;66;65 10:36:31 INFO - PROCESS | 24567 | |9;json-stringify-tinderbox;65;66;65;66;66;65;66;67;66;66 10:36:31 INFO - PROCESS | 24567 | |10;stanford-crypto-aes;83;93;83;85;82;84;98;83;82;92 10:36:31 INFO - PROCESS | 24567 | |11;stanford-crypto-ccm;136;135;142;130;130;134;134;133;177;137 10:36:31 INFO - PROCESS | 24567 | |12;stanford-crypto-pbkdf2;180;173;173;171;176;174;177;172;177;175 10:36:31 INFO - PROCESS | 24567 | |13;stanford-crypto-sha256-iterative;70;70;73;69;69;68;70;68;67;70 10:36:31 INFO - PROCESS | 24567 | __end_tp_report 10:36:31 INFO - PROCESS | 24567 | __start_cc_report 10:36:31 INFO - PROCESS | 24567 | _x_x_mozilla_cycle_collect,1975 10:36:31 INFO - PROCESS | 24567 | __end_cc_report 10:36:31 INFO - PROCESS | 24567 | __startTimestamp1472751391611__endTimestamp 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | ------- Summary: start ------- 10:36:31 INFO - PROCESS | 24567 | Number of tests: 14 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#0] ai-astar Cycles:10 Average:116.20 Median:115.00 stddev:6.03 (5.2%) stddev-sans-first:6.40 10:36:31 INFO - PROCESS | 24567 | Values: 116.0 115.0 133.0 116.0 114.0 114.0 113.0 115.0 114.0 112.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:150.50 stddev:22.81 (15.2%) stddev-sans-first:24.15 10:36:31 INFO - PROCESS | 24567 | Values: 152.0 125.0 149.0 185.0 129.0 148.0 160.0 129.0 183.0 122.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.64 (1.0%) stddev-sans-first:1.73 10:36:31 INFO - PROCESS | 24567 | Values: 162.0 163.0 164.0 161.0 163.0 162.0 160.0 163.0 160.0 159.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:40.08 (52.7%) stddev-sans-first:41.94 10:36:31 INFO - PROCESS | 24567 | Values: 76.0 74.0 75.0 177.0 75.0 76.0 76.0 76.0 164.0 78.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:83.00 stddev:26.83 (32.3%) stddev-sans-first:27.83 10:36:31 INFO - PROCESS | 24567 | Values: 84.0 83.0 147.0 83.0 84.0 83.0 138.0 83.0 84.0 130.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:36:31 INFO - PROCESS | 24567 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:36:31 INFO - PROCESS | 24567 | Values: 148.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:36:31 INFO - PROCESS | 24567 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:3.44 (5.1%) stddev-sans-first:0.88 10:36:31 INFO - PROCESS | 24567 | Values: 77.0 66.0 67.0 68.0 66.0 66.0 67.0 67.0 66.0 65.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 10:36:31 INFO - PROCESS | 24567 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 66.0 67.0 66.0 66.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:84.50 stddev:5.68 (6.7%) stddev-sans-first:5.88 10:36:31 INFO - PROCESS | 24567 | Values: 83.0 93.0 83.0 85.0 82.0 84.0 98.0 83.0 82.0 92.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:135.50 stddev:13.86 (10.2%) stddev-sans-first:14.67 10:36:31 INFO - PROCESS | 24567 | Values: 136.0 135.0 142.0 130.0 130.0 134.0 134.0 133.0 177.0 137.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.50 stddev:2.74 (1.6%) stddev-sans-first:2.17 10:36:31 INFO - PROCESS | 24567 | Values: 180.0 173.0 173.0 171.0 176.0 174.0 177.0 172.0 177.0 175.0 10:36:31 INFO - PROCESS | 24567 | 10:36:31 INFO - PROCESS | 24567 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.65 (2.4%) stddev-sans-first:1.73 10:36:31 INFO - PROCESS | 24567 | Values: 70.0 70.0 73.0 69.0 69.0 68.0 70.0 68.0 67.0 70.0 10:36:31 INFO - PROCESS | 24567 | -------- Summary: end -------- 10:36:31 INFO - PROCESS | 24567 | 10:36:32 INFO - TEST-INFO | 24567: exit 0 10:36:32 INFO - TEST-OK | kraken | took 64870ms 10:36:32 INFO - SUITE-END | took 1186s 10:36:33 INFO - Completed test suite (00:19:46) 10:36:33 INFO - javascript benchmark 10:36:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2543.38958649924, 2566.1788227767124, 2575.8454492730425, 2581.019212699174, 2596.857172855492, 4534.093181363733, 4587.357769912211, 4599.655025873056, 4613.261878099501, 4646.047560250149, 4648.581627653519, 4687.835925742591, 4730.4559975602815, 4746.193147164981, 4817.759112044392, 4228.640565551932, 4303.935440968388, 4321.58944900234, 4325.805338759747, 4453.487848897385, 4378.562143785628, 4388.626966707834, 4390.2536568783225, 4390.978045109786, 4423.049044455442, 4174.91650166995, 4211.810468528924, 4224.38746381776, 4307.6769242306955, 4387.232234359007, 4280.871573852789, 4285.185814695229, 4286.121345124273, 4286.849960251377, 4287.742735435852, 4233.936490952638, 4240.9151816963795, 4274.764887931163, 4279.33670281107, 4340.197063543223, 4622.560856718606, 4628.976855115703, 4629.583337499641, 4684.718916864965, 4696.178168820443, 4995.050940321364, 5006.299118123466, 5009.223570346602, 5014.648974571782, 5065.772040258197, 4866.902661946777, 4903.509649035103, 4941.036497882914, 5033.572146367563, 5097.5667068299235, 4623.53764623535, 4626.306054091846, 4627.074585082997, 4680.648951328664, 4685.390899183084, 5021.799128034838, 5046.6719663221775, 5061.5950723942, 5061.645684802103, 5099.745012749348, 4658.953410465852, 4829.903401932012, 4889.682170658896, 4969.90060198794, 4973.229149481836, 5073.771680274396, 5073.822416215488, 5077.746112694351, 5103.234514822806, 5134.666246694028, 4879.609631229493, 4891.63312751538, 4894.755262236945, 4895.0209958008545, 4955.430125535538, 4782.5456581625385, 4878.195097808822, 4879.902401951941, 4888.144574699413, 4939.53074457926, 4258.276093064186, 4276.102018576072, 4287.421198138274, 4336.956630433719, 4338.154059958278, 3697.5378077740284, 3698.7965661888857, 3699.8335074921692, 3736.7010639148803, 3749.643783840531, 4202.768847713344, 4253.723507971972, 4293.677974151951, 4302.483701955785, 4343.69594128408, 4962.305277261186, 5003.399592048904, 5026.220935754964, 5026.773795179226, 5073.543381095719, 4295.5489673583825, 4328.069465064963, 4331.0, 4334.349847522897, 4379.430674012358, 4388.144311859221, 4542.409486766765, 4545.977155140067, 4552.453705555288, 4599.0, 4670.78981445829, 4671.602913752369, 4675.392199014106, 4693.812247510062, 4761.952380476151, 4939.135651261086, 4950.133726597759, 4951.529604687549, 4962.776675049559, 5013.122703526941, 4598.517155698603, 4653.092646933816, 4681.368015317888, 4703.247480403119, 4759.286107083965, 4808.903821923612, 4855.781489833037, 4873.366462359871, 4877.756112194305, 4878.365812444502, 4942.332785073969, 4999.175136102648, 5011.373578302712, 5013.197888337849, 5080.568151707146, 4853.9029219416125, 4872.415310162662, 4879.682820616648, 4882.072406242944, 4940.382452193476, 4726.763661816826, 4872.780724867319, 4876.853694389174, 4883.4783303136255, 4937.654364194472, 4666.929996049994, 4735.005648813788, 4770.952290477189, 4786.856394308176, 4861.4895435978715, 4971.9502804972935, 4982.377202849644, 4984.651074424755, 5023.572996295356, 5047.116754568009, 4757.35775670294, 4848.927266091082, 4863.148948933852, 4868.926966095582, 4923.5814955729165], "value": 4582.777831458815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7350731909662, 573.7848306884919, 580.6429046136627, 588.3498733899041, 591.9348871624122, 27531.862340688294, 37688.05779855502, 38700.612993870054, 38714.80642596783, 42345.78827105868, 39158.0, 39576.80211598945, 39622.207555848865, 39653.40519892204, 39674.60325396752, 7658.2724641159275, 7810.1408845027, 7814.179511151333, 7814.413918956073, 7819.648115834772, 7190.316919892628, 9768.804623907517, 10055.296129270953, 10065.245106616996, 10404.271700980935, 10039.0, 10168.44073575953, 10170.847437288447, 10171.898281017206, 10182.64360747374, 10034.498275086253, 10097.040781125856, 10098.646547370843, 10101.494925253708, 10111.544980475895, 9803.215742740564, 9877.259205559612, 9883.703488895344, 9885.851712224323, 9893.406395616286, 36401.45397819035, 36670.266594668225, 36783.0, 36784.0, 36817.815910920544, 2805.7895657825743, 2897.377063931244, 3273.453885553068, 3379.3072420154053, 3686.576043754949, 27723.168304950883, 28145.859270703517, 28379.432411351656, 28413.573796392862, 28428.0, 3451.4650229214512, 3554.129238336598, 3560.483729859182, 3571.196480791827, 3607.116256517144, 251761.0, 254100.0, 254347.0, 254507.0, 255270.0, 49223.507764921895, 49428.50571494239, 49450.75274623604, 49498.0, 49622.50377496251, 32320.191995200308, 33561.83219083889, 33626.0, 33636.32727345488, 33646.831765841016, 15294.617634559225, 15460.304286306919, 15464.0, 15470.226488675522, 15479.613009674624, 10521.316114452537, 10780.35317880914, 11703.648890533297, 11785.0, 11856.466459009365, 15424.845751542342, 15542.300596473186, 16747.729329021022, 17409.0, 17478.0, 6579.934200658028, 6640.667966601651, 6665.600063996176, 6671.766488172891, 6882.208546017172, 748.8015675845905, 775.6276987046249, 785.9331956783623, 892.5715656484793, 928.7399528132133, 25846.0, 26597.601035984477, 27641.308967275978, 28174.43651126966, 28504.28739281493, 933.5005771911995, 949.8432758594754, 958.2956526952685, 1012.3268026762121, 1016.3698506925606, 14545.490907818175, 14810.0, 14824.110553366832, 14845.554633361016, 14944.70110597782, 373606.0, 378021.0, 378393.0, 378868.0, 380485.0, 49126.0, 49673.75163124233, 49695.25457118146, 49788.25317620239, 49792.25311620328, 1130.2032067392634, 1145.725025993772, 1186.875378085323, 1190.892819646236, 1191.231655582162, 25701.61447578325, 26091.608625871006, 27297.454050918474, 27784.583231251952, 27829.860850695615, 42716.0, 43350.93086967764, 43443.782781085894, 43458.78270608627, 43465.78267108644, 354611.0, 356822.0, 357000.0, 357265.0, 357805.0, 29098.854505727337, 31085.844570777, 32274.0, 37711.62288377191, 38410.0, 34910.65089349074, 35025.0, 40082.39876401798, 40648.79675601603, 41589.79205103955, 31855.681443185273, 33797.0, 34900.301993959474, 35438.82280588581, 35749.0, 34183.0, 34246.828765857004, 34714.82642586872, 34832.82583587066, 34992.65007349894, 34115.82942085274, 34255.31489370248, 34263.65736342605, 34506.65493345135, 35041.0, 27588.586171207047, 29496.0, 30450.390992180477, 31422.842885785423, 32558.0, 24420.75579244256, 24738.628920566567, 24798.38004049913, 24904.377390564656, 24984.37539061538], "value": 17620.759437884237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.95191737325115, 360.18238598381674, 367.1390589068634, 369.95745489268734, 390.7089218532194, 12343.691407714812, 14222.786658200135, 16011.599710007256, 16027.759583606241, 16056.0, 15638.687226255497, 15883.841161588382, 16079.0, 16147.515574532754, 16873.40943066993, 4341.826326946918, 5070.518300761421, 5096.159133742946, 5104.055749686301, 5106.0, 3373.1398493384154, 3568.1614820517157, 4909.116359055369, 4979.253112033188, 4980.352554167953, 3608.566971963368, 3717.2379662169324, 5762.884742305151, 5771.797987070453, 5870.090136028923, 5728.25532680753, 5850.795222167247, 5853.414658534134, 5860.033094539439, 5867.325257595388, 5144.4083930348115, 5184.144616138333, 5199.714015729133, 5205.219217117425, 5206.5314121729225, 12432.564860229848, 12480.126391152622, 12506.937465312707, 20148.899255503628, 20285.188592456285, 1836.8703247502824, 1842.7880793708628, 1893.1480833624787, 1951.4926119208965, 2076.5535409886797, 8934.329925255632, 9082.954585227031, 9129.315301352424, 9266.397684150508, 9619.134277915022, 1733.16807932192, 1747.405882000126, 1752.6582316448298, 1753.158483927709, 1789.6152327249574, 49347.753261233825, 62063.689681551754, 63476.36523634797, 66468.0, 69915.65042174807, 9858.654947076819, 9900.603975840886, 10341.74145646365, 10404.479776011169, 10535.683929482127, 13752.793708094387, 13814.723705525834, 13818.861811381757, 13831.446742130202, 13851.0, 7056.964715176391, 7112.57324560528, 7131.0373099631925, 7208.2791720828545, 7463.477556570988, 6573.474122070223, 6611.578510620144, 6804.4216241620015, 6814.011968264574, 6826.488013399015, 4052.371882358239, 4187.539370669224, 4328.696991210648, 4352.347147927836, 4455.888602784957, 1718.3813827022261, 1772.2556526259002, 1826.5159732670588, 1861.500379286932, 1887.160213704888, 798.7044793426469, 812.7277362083768, 813.9837203255902, 817.4727300890892, 828.1842385250524, 16268.918655406647, 16285.185740712917, 16503.587410314598, 16664.666706665797, 17368.218430170673, 806.0810675829559, 816.1715858403725, 837.6398148795954, 844.3793811548506, 871.808202195516, 9113.179813816789, 9314.161725444606, 9374.953125234466, 9431.386959847589, 9697.321187516947, 371040.0, 373171.0, 390662.0, 392465.0, 392828.0, 78515.0, 78887.60556197182, 81133.59433202914, 81459.0, 83529.0, 889.4974339498162, 892.1034360467688, 925.3430064654036, 948.9145976862116, 950.805084957582, 13862.0, 13906.652333691738, 13986.580402587939, 14022.439102435788, 14789.926050369679, 37794.8110259458, 39172.0, 39376.803115985385, 40143.598564015156, 40417.39373909453, 51610.74194629003, 52804.73597631987, 53284.0, 53354.46645533495, 53541.0, 7388.298111679382, 7630.2751238632245, 7692.8461430772195, 7710.7686769397005, 7830.765077047698, 8716.738497845075, 11460.426978650867, 11805.409729513662, 11829.76340473203, 12067.637970860887, 9911.0, 10184.287099903231, 10298.845517317395, 10498.737531561772, 10751.784964300514, 10067.29528932997, 10078.395296282246, 10111.64609238673, 10140.188784897044, 10344.793104138025, 9684.757881052748, 9938.0, 10112.49437528106, 10192.694219173436, 10611.787764244826, 7439.8140046499275, 7475.476716629783, 7637.083549974039, 7712.074551053909, 8074.919250807417, 8760.853590870278, 9798.167155791838, 9973.351732137678, 10178.949105254722, 10572.89427105719], "value": 7965.509527844118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.3873102179932, 1292.5088466382774, 1303.9828933431922, 1622.7160246956787, 1626.3494602159128, 6626.668666566665, 7246.130464344279, 7362.0, 7798.3761299096, 7800.219978002204, 7429.331360177583, 7704.653290601922, 7715.922840771591, 7726.8840967385395, 7736.845263094749, 2140.8715477071346, 2172.0985790896757, 2172.3048624440185, 2173.445771328309, 2174.9782502174935, 1798.0829776813853, 2045.795420457957, 2088.853780235384, 2112.6197284488785, 2118.629239883022, 2147.602693501707, 2169.4684802223396, 2170.251263314154, 2171.522265101675, 2171.869687818736, 2073.5852829434098, 2122.9363119106374, 2151.257816053459, 2151.580441813847, 2155.611989841828, 2088.6136064828056, 2101.53766171442, 2108.7996640319143, 2114.027547328231, 2137.444264491228, 7682.116556596007, 7761.650725717356, 7767.223277672244, 7776.805579860492, 7784.182660820646, 4279.293916503773, 4410.492793328776, 4415.911681766347, 4416.867493975154, 4417.712848664826, 2765.847878366689, 2843.8720257588457, 2895.7104289571084, 2925.18094933419, 2936.6329208848892, 906.3338446242007, 933.8365785987424, 959.9088086631759, 965.6330594374093, 970.8689326940843, 10327.58689652413, 10338.7415314617, 10349.58601655933, 10358.274920755475, 10378.9481052595, 3761.4921985531605, 4006.419069234945, 4177.12280421115, 4187.853425130106, 4195.139996300751, 8883.866741998876, 8886.066962968795, 8902.955485222532, 8909.331800115016, 8911.955440222757, 4501.954980450219, 4505.166544189336, 4505.346724724896, 4517.706349087299, 4525.389072475239, 4085.550589435219, 4135.503739551213, 4144.689148313889, 4157.189348077157, 4164.5210800757695, 3565.607783143852, 3643.5081264029545, 3659.0486473516544, 3685.336639404933, 3716.0524066362905, 1063.3619828103076, 1161.9070474362031, 1165.877582853805, 1196.6170825335982, 1204.801207800703, 817.5708445922558, 820.9466384684977, 832.0556168748393, 844.0883845447025, 845.2308399356679, 5215.843524694265, 5464.426235245322, 5487.6981766002455, 5700.543956483471, 5716.857078572986, 799.9720009799629, 836.4479443567338, 840.1556435781999, 854.1714536899322, 901.3014913442134, 3588.246468241646, 3666.633336666312, 3667.614900435416, 3693.464447655129, 3743.457198706172, 9101.226395756436, 9459.858102128474, 9678.080582344666, 9678.128968392879, 9712.660056897974, 9541.522923853918, 9609.183219426428, 9625.71122866315, 9636.132748052569, 9647.421154730599, 7075.327843854826, 7093.964530177316, 7180.9640951795955, 7207.783766487014, 7213.963930180421, 5055.064813009605, 5080.593552515864, 5153.4073581538605, 5247.2129180623215, 5363.302770639792, 8685.39202255836, 8776.736697899074, 8843.275561265491, 8915.598798053974, 8957.28341732673, 8869.290456763314, 8929.374943753875, 9009.414388064755, 9011.188992990663, 9088.0, 6304.779332723516, 6418.229812422539, 6423.775167869289, 6430.099786029866, 6430.5177111715875, 6961.79114626562, 7018.087648605649, 7111.679974401268, 7261.092363454568, 7321.707131714672, 5422.942526207509, 6353.4599559038, 6373.968130159319, 6538.1500404947055, 6708.798736037927, 6415.615063096229, 6440.484761219185, 6441.291457939717, 6461.1600491937625, 6472.967635161983, 6109.327973922776, 6240.251169859646, 6248.718807653576, 6272.780452684134, 6277.686115694106, 4483.30508771141, 4499.77501124949, 4501.6848820582245, 4538.455385353779, 4575.862724118282, 4321.243782338015, 4399.516053234078, 4437.134758722018, 4444.377787109743, 4465.419495465569], "value": 4063.6823841526993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.0923089193406, 300.1805072153022, 306.2726025688989, 309.1452134847148, 310.02188096555375, 4815.771978145573, 4836.854894353166, 4852.403963879326, 4867.829625963092, 4884.853454396365, 4776.355192049073, 4783.330333753269, 4812.879678008052, 4816.133096042711, 4823.9758801206035, 3574.5531808523933, 3608.260306637146, 3725.1990821973272, 3738.3644780387262, 3754.8498060077563, 3734.2904848078915, 3736.514253147087, 3749.568799588055, 3751.3060083884434, 3769.6795772359383, 3710.2208536207295, 3711.294853977736, 3712.5916149223563, 3729.552453705559, 3744.7191460640424, 3545.92908141837, 3591.317649646559, 3710.5361829771277, 3729.5710993235853, 3759.3984962405884, 3288.7369010479106, 3297.653746356622, 3306.487494438366, 3309.0, 3317.8672853085845, 4628.54200926707, 4633.6061434778085, 4642.816081899128, 4647.744374059425, 4697.3893393858925, 4146.543880173179, 4268.637165840907, 4274.914501709979, 4284.400183974246, 4289.297742422285, 4910.459849416561, 4939.407271127452, 4959.305697202394, 4976.377952755905, 4997.325361076245, 3599.94600080999, 3605.47720580517, 3609.3864043112735, 3657.6159503252043, 3663.835127419246, 4934.358533390637, 5198.634621247361, 5242.344706911636, 5250.7112108834, 5260.815871444481, 3568.982155089208, 3584.444411116281, 3586.193106551057, 3586.8385922633543, 3617.9276414471565, 3612.164450906079, 3622.800745958945, 3625.274945011008, 3648.927021459556, 3652.3243200008083, 4178.35235538492, 4186.597489840938, 4186.874393768192, 4201.411802347674, 4228.746275223435, 4836.3712717347225, 4964.205727083649, 4965.950340496549, 5070.366204224472, 5071.847844564669, 1251.330538162079, 1255.2656695832857, 1262.3435813376993, 1262.4319056424463, 1263.4693428759942, 776.4099284543674, 792.9563873986987, 802.827392110699, 804.8470790549777, 805.2269820971933, 4213.557576454489, 4267.765272909957, 4463.991203958231, 4471.5081341052455, 4494.483134439516, 5080.974595127001, 5104.3619547556555, 5110.437851836295, 5150.27896094547, 5174.379074511007, 4423.407573273619, 4430.139341476588, 4434.733915965053, 4439.246497633417, 4453.265211240174, 2617.816752827284, 2657.6677915260593, 2705.269577214141, 2714.538528450168, 2734.1387462949106, 4854.441739199967, 4859.2954021666665, 4897.681650692693, 4900.313956046157, 4919.901601968012, 5056.620753443506, 5250.527452529291, 5256.737163141904, 5266.78932842682, 5275.522853600921, 4851.223804191383, 4864.562189402971, 4878.878028049327, 4898.583620392164, 4922.507749225048, 5119.97600479898, 5130.51260130287, 5134.5635620972635, 5163.66436181647, 5170.879939224899, 4744.667873248839, 5030.5975521957425, 5059.19052951526, 5068.0, 5086.54221120101, 4792.3530323407285, 4823.1800593898415, 4827.493113223061, 4843.975780121077, 4862.756862156949, 3602.5496812898386, 3644.143626247883, 3655.2324011957785, 3679.3377192105677, 3682.447632854986, 5108.821191258288, 5143.048536020848, 5156.793728250828, 5210.687358758487, 5211.687298762086, 4737.715737055788, 5013.0, 5016.147254966738, 5033.622478314068, 5052.722100284373, 4992.2761199626575, 5002.474740152232, 5003.174476211384, 5031.6226283029655, 5032.798688052437, 4765.925977744266, 4917.926231106465, 4920.892799120169, 4947.703137811743, 4951.801927922843, 4804.711717296974, 4918.188498897642, 5038.211434940544, 5042.546170844642, 5099.413567439792, 4918.213085906238, 4943.233798761198, 4945.727984960861, 4950.282209079735, 4953.900921981613], "value": 3762.887282446916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.9485148910853, 598.0, 609.7560975609758, 620.3889169168368, 621.947134493568, 11464.0, 12377.381130943462, 12380.81428778569, 12392.690182745424, 12897.935510322435, 13400.731985360288, 13985.440582376717, 14053.0, 14053.92973035136, 14096.295185240722, 730.0509337860786, 754.3022703998806, 755.9697612095509, 756.8599809035346, 757.23141011873, 600.7026521871679, 718.2279050021222, 749.6064566102785, 751.7669522448032, 754.1139161485261, 792.0376742258155, 793.972210972616, 794.0392125528118, 794.3605397654885, 794.6503538443095, 788.4874831359662, 788.5938741548107, 788.6963519045152, 788.9368850491946, 789.3448437796644, 460.0454057830016, 550.6998685716294, 565.2199964049627, 566.0914232656609, 577.0997244298907, 12032.157748957576, 12200.755984880252, 12205.596356419037, 12229.510819567207, 12230.388480575935, 11490.36802975836, 11781.528738850435, 12144.635660930186, 12146.514139434412, 12408.160832178366, 11412.942935285353, 11445.25605835618, 11463.426828658618, 11599.246049006788, 11617.477213525328, 3930.9017274568077, 3966.504186976628, 3989.6209860063245, 3997.980010099931, 4008.4388185654034, 66235.3376466234, 67315.66342168307, 68037.65981170112, 68330.65834670844, 68567.65716171438, 9489.145976862115, 9759.609615615438, 9858.704238872846, 9951.552180151766, 10206.285560010729, 17323.826761732475, 18631.627367452576, 18645.50835933122, 18665.44003679892, 18672.533186670444, 6636.8672626547195, 6723.865522689519, 6808.6936087876165, 6825.419839313714, 6877.58734475933, 3656.561212654445, 3747.756395834262, 3793.6016718244737, 3870.7290489666016, 3879.7866117363815, 2983.298924752681, 3084.0593618946436, 3106.502959526465, 3106.673799251046, 3107.5183346580866, 514.4161376837242, 532.5384997516145, 532.7229840482927, 536.9785208591691, 553.261396036288, 511.1616948204947, 527.6174773289334, 530.5278302310946, 553.9778408863681, 588.109014842514, 7936.16670249627, 7981.800454988672, 8210.343172546302, 8373.162683731578, 8509.916765992364, 496.39439883342266, 524.1979770950452, 568.139269007454, 575.7840809696364, 582.988340233193, 3606.098475381155, 3745.0824547985917, 3868.7485313454536, 3918.9020274493364, 3984.907461261936, 98719.0, 102043.0, 102597.0, 103281.48359258306, 105360.0, 67176.66411667911, 68732.65633671799, 87611.04861892264, 91715.54142229246, 91723.0, 65158.999999999054, 67848.32151678519, 68577.0, 71239.0, 71841.0, 8122.55325957078, 8550.957245213734, 8593.742187734379, 8638.352123590881, 8656.350773692124, 30438.239044024078, 38090.23819523538, 38477.2304553913, 38578.80710596429, 43456.565434345255, 59266.44304360608, 60243.39756602378, 60496.39503605084, 60647.0, 60684.393156069644, 10604.151667866707, 10967.561297548009, 11030.87711276889, 11365.886341136813, 11832.881671183179, 11999.76000479968, 12586.370681465707, 12614.243145411305, 12682.936585317015, 12894.419751111034, 11477.0, 11489.482973266056, 11531.481083351437, 11694.181407301407, 11835.323415169183, 9139.817203655757, 11147.275427097213, 11245.718857028312, 11432.657020289405, 11703.414829258332, 10851.403172825254, 11098.056665183227, 11113.722156946142, 11242.66272011841, 11891.821622675494, 9729.756756081155, 9752.219822414048, 9922.751931201778, 10201.132903702972, 10899.51215610997, 9144.359894807565, 9819.312648114563, 9830.508474576385, 9839.704808855746, 9866.654667086617], "value": 6442.657336798643, "unit": "score"}], "name": "dromaeo_css", "value": 6314.233724654798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 133.0, 116.0, 114.0, 114.0, 113.0, 115.0, 114.0, 112.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 149.0, 185.0, 129.0, 148.0, 160.0, 129.0, 183.0, 122.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 161.0, 163.0, 162.0, 160.0, 163.0, 160.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 177.0, 75.0, 76.0, 76.0, 76.0, 164.0, 78.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 147.0, 83.0, 84.0, 83.0, 138.0, 83.0, 84.0, 130.0], "value": 99.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 66.0, 67.0, 68.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 93.0, 83.0, 85.0, 82.0, 84.0, 98.0, 83.0, 82.0, 92.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 142.0, 130.0, 130.0, 134.0, 134.0, 133.0, 177.0, 137.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 173.0, 173.0, 171.0, 176.0, 174.0, 177.0, 172.0, 177.0, 175.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 69.0, 69.0, 68.0, 70.0, 68.0, 67.0, 70.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1583.8999999999999, "alertThreshold": 2.0}]} 10:36:33 INFO - Return code: 0 10:36:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:33 INFO - # TBPL SUCCESS # 10:36:33 INFO - Running post-action listener: _resource_record_post_action 10:36:33 INFO - [mozharness: 2016-09-01 17:36:33.422814Z] Finished run-tests step (success) 10:36:33 INFO - Running post-run listener: _resource_record_post_run 10:36:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416788480; Read time: 12; Write time: 413320 10:36:33 INFO - TinderboxPrint: CPU usage
13.0% 10:36:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:36:33 INFO - TinderboxPrint: I/O write bytes / time
416,788,480 / 413,320 10:36:33 INFO - TinderboxPrint: CPU idle
8,346.3 (86.9%) 10:36:33 INFO - TinderboxPrint: CPU user
1,202.3 (12.5%) 10:36:33 INFO - TinderboxPrint: Swap in / out
0 / 0 10:36:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124997632; Read time: 0; Write time: 93540 10:36:33 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291790848; Read time: 0; Write time: 319780 10:36:34 INFO - Running post-run listener: _upload_blobber_files 10:36:34 INFO - Blob upload gear active. 10:36:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:34 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 10:36:34 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:36:34 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:36:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:35 INFO - (blobuploader) - INFO - Done attempting. 10:36:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:40 INFO - (blobuploader) - INFO - Done attempting. 10:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:41 INFO - (blobuploader) - INFO - Done attempting. 10:36:41 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:41 INFO - Return code: 0 10:36:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/32a1db38b2a5317b03f49421505b1f41a998d74a119160f7b2fd9b23e17c7d6ea7c94273ca0de5f84907ec871c78bb27a1263c5b4091b7087e84e49ab476f2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3bc1d70c8d50461b3410716f52de233d2f90c845627204f6e0c3dac5a934099fde0b9c62b5c6342d6c87ccbb107641263e1bac77faa95ce416640db1383a7c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38163eb2216407cadd8858e8e73f5bcfcfa4ae0e1ff69e0722b86fff80bb5b3462f2276068ad59cebc05d4dab091d29ab1aa68e0d42a12dd3fec8ea773a3124c"} 10:36:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:41 INFO - Contents: 10:36:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/32a1db38b2a5317b03f49421505b1f41a998d74a119160f7b2fd9b23e17c7d6ea7c94273ca0de5f84907ec871c78bb27a1263c5b4091b7087e84e49ab476f2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3bc1d70c8d50461b3410716f52de233d2f90c845627204f6e0c3dac5a934099fde0b9c62b5c6342d6c87ccbb107641263e1bac77faa95ce416640db1383a7c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38163eb2216407cadd8858e8e73f5bcfcfa4ae0e1ff69e0722b86fff80bb5b3462f2276068ad59cebc05d4dab091d29ab1aa68e0d42a12dd3fec8ea773a3124c"} 10:36:41 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:41 INFO - Copying logs to upload dir... 10:36:41 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.161712 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-01 10:36:41.605661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 10:36:41.609500) ========= 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=836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/32a1db38b2a5317b03f49421505b1f41a998d74a119160f7b2fd9b23e17c7d6ea7c94273ca0de5f84907ec871c78bb27a1263c5b4091b7087e84e49ab476f2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3bc1d70c8d50461b3410716f52de233d2f90c845627204f6e0c3dac5a934099fde0b9c62b5c6342d6c87ccbb107641263e1bac77faa95ce416640db1383a7c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38163eb2216407cadd8858e8e73f5bcfcfa4ae0e1ff69e0722b86fff80bb5b3462f2276068ad59cebc05d4dab091d29ab1aa68e0d42a12dd3fec8ea773a3124c"} build_url:https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/NUkYasHmTJqIqeg3eU_kXg/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/Autoland-Non-PGO/sha512/32a1db38b2a5317b03f49421505b1f41a998d74a119160f7b2fd9b23e17c7d6ea7c94273ca0de5f84907ec871c78bb27a1263c5b4091b7087e84e49ab476f2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3bc1d70c8d50461b3410716f52de233d2f90c845627204f6e0c3dac5a934099fde0b9c62b5c6342d6c87ccbb107641263e1bac77faa95ce416640db1383a7c19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38163eb2216407cadd8858e8e73f5bcfcfa4ae0e1ff69e0722b86fff80bb5b3462f2276068ad59cebc05d4dab091d29ab1aa68e0d42a12dd3fec8ea773a3124c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 10:36:41.634772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:36:41.635118) ========= 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=836cfdc75598d54cb747368e000001a9-1472750065.976385-1082478697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:36:41.720295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 10:36:41.720721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 10:36:41.721022) ========= ========= Total master_lag: 0.44 =========