builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1471620573.6 results: success (0) buildid: 20160819071321 builduid: 291cfaf5f55942c2b854a32cebb91351 revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.604797) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.605832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.606529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.622629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.623311) ========= 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=41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 08:29:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.3M=0s 2016-08-19 08:29:33 (67.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.749871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.750471) ========= 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=41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015139 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.801974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:33.802762) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c --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=41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 08:29:33,918 truncating revision to first 12 chars 2016-08-19 08:29:33,919 Setting DEBUG logging. 2016-08-19 08:29:33,919 attempt 1/10 2016-08-19 08:29:33,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/23c2ec5544b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 08:29:34,290 unpacking tar archive at: fx-team-23c2ec5544b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:34.533375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:34.533767) ========= script_repo_revision: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:34.534231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:34.534549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:29:34.544345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-19 08:29:34.544655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:34 INFO - MultiFileLogger online at 20160819 08:29:34 in /builds/slave/test 08:29:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:29:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:29:34 INFO - {'append_to_log': False, 08:29:34 INFO - 'base_work_dir': '/builds/slave/test', 08:29:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:29:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:29:34 INFO - 'branch': 'Fx-Team-Non-PGO', 08:29:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:34 INFO - 'config_files': ('talos/linux_config.py',), 08:29:34 INFO - 'default_actions': ('clobber', 08:29:34 INFO - 'read-buildbot-config', 08:29:34 INFO - 'download-and-extract', 08:29:34 INFO - 'populate-webroot', 08:29:34 INFO - 'create-virtualenv', 08:29:34 INFO - 'install', 08:29:34 INFO - 'run-tests'), 08:29:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:34 INFO - 'download_minidump_stackwalk': True, 08:29:34 INFO - 'download_symbols': 'ondemand', 08:29:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:34 INFO - 'installer_path': 'installer.exe', 08:29:34 INFO - 'log_level': 'info', 08:29:34 INFO - 'log_name': 'talos', 08:29:34 INFO - 'log_to_console': True, 08:29:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:34 INFO - 'opt_config_files': (), 08:29:34 INFO - 'pip_index': False, 08:29:34 INFO - 'sps_profile': False, 08:29:34 INFO - 'sps_profile_interval': 0, 08:29:34 INFO - 'suite': 'dromaeojs', 08:29:34 INFO - 'system_bits': '32', 08:29:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:34 INFO - 'title': 'talos-linux64-ix-024', 08:29:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:34 INFO - 'use_talos_json': True, 08:29:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:29:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:34 INFO - 'work_dir': 'build'} 08:29:34 INFO - [mozharness: 2016-08-19 15:29:34.750235Z] Running clobber step. 08:29:34 INFO - Running pre-action listener: _resource_record_pre_action 08:29:34 INFO - Running main action method: clobber 08:29:34 INFO - rmtree: /builds/slave/test/build 08:29:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:29:35 INFO - Running post-action listener: _resource_record_post_action 08:29:35 INFO - [mozharness: 2016-08-19 15:29:35.234277Z] Finished clobber step (success) 08:29:35 INFO - [mozharness: 2016-08-19 15:29:35.234378Z] Running read-buildbot-config step. 08:29:35 INFO - Running pre-action listener: _resource_record_pre_action 08:29:35 INFO - Running main action method: read_buildbot_config 08:29:35 INFO - Using buildbot properties: 08:29:35 INFO - { 08:29:35 INFO - "project": "", 08:29:35 INFO - "product": "firefox", 08:29:35 INFO - "script_repo_revision": "production", 08:29:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:29:35 INFO - "repository": "", 08:29:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:29:35 INFO - "buildid": "20160819071321", 08:29:35 INFO - "pgo_build": "False", 08:29:35 INFO - "basedir": "/builds/slave/test", 08:29:35 INFO - "buildnumber": 1874, 08:29:35 INFO - "slavename": "talos-linux64-ix-024", 08:29:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:29:35 INFO - "platform": "ubuntu64_hw", 08:29:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:29:35 INFO - "branch": "fx-team", 08:29:35 INFO - "repo_path": "integration/fx-team", 08:29:35 INFO - "revision": "23c2ec5544b9e0a74a047b87b594e4c36a8fe95c", 08:29:35 INFO - "stage_platform": "linux64", 08:29:35 INFO - "builduid": "291cfaf5f55942c2b854a32cebb91351", 08:29:35 INFO - "slavebuilddir": "test" 08:29:35 INFO - } 08:29:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:29:35 INFO - Running post-action listener: _resource_record_post_action 08:29:35 INFO - [mozharness: 2016-08-19 15:29:35.236819Z] Finished read-buildbot-config step (success) 08:29:35 INFO - [mozharness: 2016-08-19 15:29:35.236907Z] Running download-and-extract step. 08:29:35 INFO - Running pre-action listener: _resource_record_pre_action 08:29:35 INFO - Running main action method: download_and_extract 08:29:35 INFO - mkdir: /builds/slave/test/build/tests 08:29:35 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')]} 08:29:35 INFO - trying https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:29:35 INFO - Downloading https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:35 INFO - Downloaded 1361 bytes. 08:29:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:29:35 INFO - Using the following test package requirements: 08:29:35 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:29:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:29:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'jsshell-linux-x86_64.zip'], 08:29:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:29:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:29:35 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:29:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:29:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:29:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:29:35 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')]} 08:29:35 INFO - trying https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:29:35 INFO - Downloading https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:37 INFO - Downloaded 20328569 bytes. 08:29:37 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 08:29:41 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 08:29:41 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')]} 08:29:41 INFO - trying https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:29:41 INFO - Downloading https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:42 INFO - Downloaded 20328569 bytes. 08:29:42 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 08:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:47 INFO - trying https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:29:47 INFO - Downloading https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:48 INFO - Downloaded 14413981 bytes. 08:29:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:49 INFO - trying https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:29:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/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 08:29:51 INFO - Downloaded 55773116 bytes. 08:29:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:29:51 INFO - mkdir: /builds/slave/test/properties 08:29:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:29:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:29:51 INFO - Contents: 08:29:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:29:51 INFO - Running post-action listener: _resource_record_post_action 08:29:51 INFO - Running post-action listener: set_extra_try_arguments 08:29:51 INFO - [mozharness: 2016-08-19 15:29:51.840087Z] Finished download-and-extract step (success) 08:29:51 INFO - [mozharness: 2016-08-19 15:29:51.840310Z] Running populate-webroot step. 08:29:51 INFO - Running pre-action listener: _resource_record_pre_action 08:29:51 INFO - Running main action method: populate_webroot 08:29:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:51 INFO - '--tppagecycles', 08:29:51 INFO - '7'], 08:29:51 INFO - 'tests': ['tsvgm']}}, 08:29:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:29:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:29:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:29:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['damp', 'tps']}, 08:29:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'tests': ['damp', 'tps']}, 08:29:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['dromaeo_dom']}, 08:29:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['basic_compositor_video']}, 08:29:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:29:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['a11yr', 08:29:51 INFO - 'ts_paint', 08:29:51 INFO - 'tpaint', 08:29:51 INFO - 'sessionrestore', 08:29:51 INFO - 'sessionrestore_no_auto_restore', 08:29:51 INFO - 'tabpaint']}, 08:29:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tsvgx', 08:29:51 INFO - 'tsvgr_opacity', 08:29:51 INFO - 'tart', 08:29:51 INFO - 'tscrollx', 08:29:51 INFO - 'cart']}, 08:29:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:29:51 INFO - 'tsvgr_opacity', 08:29:51 INFO - 'tart', 08:29:51 INFO - 'tscrollx', 08:29:51 INFO - 'cart']}, 08:29:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s'], 08:29:51 INFO - 'tests': ['tp5o']}, 08:29:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'tests': ['tp5o']}, 08:29:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'talos_options': ['--disable-e10s', 08:29:51 INFO - '--xperf_path', 08:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:51 INFO - 'tests': ['tp5n']}, 08:29:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:51 INFO - 'talos_options': ['--xperf_path', 08:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:51 INFO - 'tests': ['tp5n']}}, 08:29:51 INFO - 'talos.zip': {'path': '', 08:29:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:51 INFO - Running post-action listener: _resource_record_post_action 08:29:51 INFO - [mozharness: 2016-08-19 15:29:51.858262Z] Finished populate-webroot step (success) 08:29:51 INFO - [mozharness: 2016-08-19 15:29:51.858350Z] Running create-virtualenv step. 08:29:51 INFO - Running pre-action listener: _resource_record_pre_action 08:29:51 INFO - Running main action method: create_virtualenv 08:29:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:29:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:29:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:29:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:51 INFO - Using real prefix '/usr' 08:29:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:29:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:54 INFO - Installing pip.................done. 08:29:54 INFO - Return code: 0 08:29:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:29:54 INFO - Using env: {'DISPLAY': ':0', 08:29:54 INFO - 'HOME': '/home/cltbld', 08:29:54 INFO - 'LANG': 'en_US.UTF-8', 08:29:54 INFO - 'LANGUAGE': 'en_US:en', 08:29:54 INFO - 'LOGNAME': 'cltbld', 08:29:54 INFO - 'MAIL': '/var/mail/cltbld', 08:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:54 INFO - 'MOZ_NO_REMOTE': '1', 08:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:54 INFO - 'NO_EM_RESTART': '1', 08:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:54 INFO - 'PWD': '/builds/slave/test', 08:29:54 INFO - 'SHELL': '/bin/bash', 08:29:54 INFO - 'SHLVL': '1', 08:29:54 INFO - 'TERM': 'linux', 08:29:54 INFO - 'TMOUT': '86400', 08:29:54 INFO - 'USER': 'cltbld', 08:29:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:54 INFO - '_': '/tools/buildbot/bin/python'} 08:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:29:54 INFO - Cleaning up... 08:29:54 INFO - Return code: 0 08:29:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:29:54 INFO - Using env: {'DISPLAY': ':0', 08:29:54 INFO - 'HOME': '/home/cltbld', 08:29:54 INFO - 'LANG': 'en_US.UTF-8', 08:29:54 INFO - 'LANGUAGE': 'en_US:en', 08:29:54 INFO - 'LOGNAME': 'cltbld', 08:29:54 INFO - 'MAIL': '/var/mail/cltbld', 08:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:54 INFO - 'MOZ_NO_REMOTE': '1', 08:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:54 INFO - 'NO_EM_RESTART': '1', 08:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:54 INFO - 'PWD': '/builds/slave/test', 08:29:54 INFO - 'SHELL': '/bin/bash', 08:29:54 INFO - 'SHLVL': '1', 08:29:54 INFO - 'TERM': 'linux', 08:29:54 INFO - 'TMOUT': '86400', 08:29:54 INFO - 'USER': 'cltbld', 08:29:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:54 INFO - '_': '/tools/buildbot/bin/python'} 08:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:54 INFO - Downloading/unpacking psutil>=3.1.1 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:56 INFO - Installing collected packages: psutil 08:29:56 INFO - Running setup.py install for psutil 08:29:56 INFO - building 'psutil._psutil_linux' extension 08:29:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:29:57 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 08:29:57 INFO - building 'psutil._psutil_posix' extension 08:29:57 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 08:29:57 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 08:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:57 INFO - Successfully installed psutil 08:29:57 INFO - Cleaning up... 08:29:57 INFO - Return code: 0 08:29:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:29:57 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')]} 08:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 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')]} 08:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 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 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:29:57 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 08:29:57 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 08:29:57 INFO - Using env: {'DISPLAY': ':0', 08:29:57 INFO - 'HOME': '/home/cltbld', 08:29:57 INFO - 'LANG': 'en_US.UTF-8', 08:29:57 INFO - 'LANGUAGE': 'en_US:en', 08:29:57 INFO - 'LOGNAME': 'cltbld', 08:29:57 INFO - 'MAIL': '/var/mail/cltbld', 08:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:57 INFO - 'MOZ_NO_REMOTE': '1', 08:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:57 INFO - 'NO_EM_RESTART': '1', 08:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:57 INFO - 'PWD': '/builds/slave/test', 08:29:57 INFO - 'SHELL': '/bin/bash', 08:29:57 INFO - 'SHLVL': '1', 08:29:57 INFO - 'TERM': 'linux', 08:29:57 INFO - 'TMOUT': '86400', 08:29:57 INFO - 'USER': 'cltbld', 08:29:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:57 INFO - '_': '/tools/buildbot/bin/python'} 08:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:29:59 INFO - Installing collected packages: mozsystemmonitor 08:29:59 INFO - Running setup.py install for mozsystemmonitor 08:29:59 INFO - Successfully installed mozsystemmonitor 08:29:59 INFO - Cleaning up... 08:29:59 INFO - Return code: 0 08:29:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:29:59 INFO - Using env: {'DISPLAY': ':0', 08:29:59 INFO - 'HOME': '/home/cltbld', 08:29:59 INFO - 'LANG': 'en_US.UTF-8', 08:29:59 INFO - 'LANGUAGE': 'en_US:en', 08:29:59 INFO - 'LOGNAME': 'cltbld', 08:29:59 INFO - 'MAIL': '/var/mail/cltbld', 08:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:59 INFO - 'MOZ_NO_REMOTE': '1', 08:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:59 INFO - 'NO_EM_RESTART': '1', 08:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:59 INFO - 'PWD': '/builds/slave/test', 08:29:59 INFO - 'SHELL': '/bin/bash', 08:29:59 INFO - 'SHLVL': '1', 08:29:59 INFO - 'TERM': 'linux', 08:29:59 INFO - 'TMOUT': '86400', 08:29:59 INFO - 'USER': 'cltbld', 08:29:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:59 INFO - '_': '/tools/buildbot/bin/python'} 08:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:59 INFO - Downloading/unpacking jsonschema==2.5.1 08:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:30:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:30:02 INFO - warning: no files found matching '*.txt' 08:30:02 INFO - no previously-included directories found matching 'build' 08:30:02 INFO - no previously-included directories found matching 'dist' 08:30:02 INFO - no previously-included directories found matching '.git*' 08:30:02 INFO - Installing collected packages: jsonschema, functools32 08:30:02 INFO - Running setup.py install for functools32 08:30:02 INFO - warning: no files found matching '*.txt' 08:30:02 INFO - no previously-included directories found matching 'build' 08:30:02 INFO - no previously-included directories found matching 'dist' 08:30:02 INFO - no previously-included directories found matching '.git*' 08:30:02 INFO - Successfully installed jsonschema functools32 08:30:02 INFO - Cleaning up... 08:30:02 INFO - Return code: 0 08:30:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:30:02 INFO - Using env: {'DISPLAY': ':0', 08:30:02 INFO - 'HOME': '/home/cltbld', 08:30:02 INFO - 'LANG': 'en_US.UTF-8', 08:30:02 INFO - 'LANGUAGE': 'en_US:en', 08:30:02 INFO - 'LOGNAME': 'cltbld', 08:30:02 INFO - 'MAIL': '/var/mail/cltbld', 08:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:02 INFO - 'MOZ_NO_REMOTE': '1', 08:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:02 INFO - 'NO_EM_RESTART': '1', 08:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:02 INFO - 'PWD': '/builds/slave/test', 08:30:02 INFO - 'SHELL': '/bin/bash', 08:30:02 INFO - 'SHLVL': '1', 08:30:02 INFO - 'TERM': 'linux', 08:30:02 INFO - 'TMOUT': '86400', 08:30:02 INFO - 'USER': 'cltbld', 08:30:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:02 INFO - '_': '/tools/buildbot/bin/python'} 08:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:30:02 INFO - Cleaning up... 08:30:02 INFO - Return code: 0 08:30:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:30:02 INFO - Using env: {'DISPLAY': ':0', 08:30:02 INFO - 'HOME': '/home/cltbld', 08:30:02 INFO - 'LANG': 'en_US.UTF-8', 08:30:02 INFO - 'LANGUAGE': 'en_US:en', 08:30:02 INFO - 'LOGNAME': 'cltbld', 08:30:02 INFO - 'MAIL': '/var/mail/cltbld', 08:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:02 INFO - 'MOZ_NO_REMOTE': '1', 08:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:02 INFO - 'NO_EM_RESTART': '1', 08:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:02 INFO - 'PWD': '/builds/slave/test', 08:30:02 INFO - 'SHELL': '/bin/bash', 08:30:02 INFO - 'SHLVL': '1', 08:30:02 INFO - 'TERM': 'linux', 08:30:02 INFO - 'TMOUT': '86400', 08:30:02 INFO - 'USER': 'cltbld', 08:30:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:02 INFO - '_': '/tools/buildbot/bin/python'} 08:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:30:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:30:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:30:05 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 08:30:05 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 08:30:05 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 08:30:05 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 08:30:05 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 08:30:05 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 08:30:05 INFO - Downloading docopt-0.6.1.tar.gz 08:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:30:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:30:05 INFO - Running setup.py install for blobuploader 08:30:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:30:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:30:05 INFO - Running setup.py install for requests 08:30:05 INFO - Running setup.py install for docopt 08:30:05 INFO - Successfully installed blobuploader requests docopt 08:30:05 INFO - Cleaning up... 08:30:05 INFO - Return code: 0 08:30:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:05 INFO - Using env: {'DISPLAY': ':0', 08:30:05 INFO - 'HOME': '/home/cltbld', 08:30:05 INFO - 'LANG': 'en_US.UTF-8', 08:30:05 INFO - 'LANGUAGE': 'en_US:en', 08:30:05 INFO - 'LOGNAME': 'cltbld', 08:30:05 INFO - 'MAIL': '/var/mail/cltbld', 08:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:05 INFO - 'MOZ_NO_REMOTE': '1', 08:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:05 INFO - 'NO_EM_RESTART': '1', 08:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:05 INFO - 'PWD': '/builds/slave/test', 08:30:05 INFO - 'SHELL': '/bin/bash', 08:30:05 INFO - 'SHLVL': '1', 08:30:05 INFO - 'TERM': 'linux', 08:30:05 INFO - 'TMOUT': '86400', 08:30:05 INFO - 'USER': 'cltbld', 08:30:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:05 INFO - '_': '/tools/buildbot/bin/python'} 08:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:06 INFO - Running setup.py (path:/tmp/pip-eqGmTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:06 INFO - Running setup.py (path:/tmp/pip-ZYszhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:06 INFO - Running setup.py (path:/tmp/pip-s6_8ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:06 INFO - Running setup.py (path:/tmp/pip-YaHGKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:06 INFO - Running setup.py (path:/tmp/pip-LVe_Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:06 INFO - Running setup.py (path:/tmp/pip-Qx1BMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:06 INFO - Running setup.py (path:/tmp/pip-o6wJG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:06 INFO - Running setup.py (path:/tmp/pip-VeCjIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:06 INFO - Running setup.py (path:/tmp/pip-e3UrET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:06 INFO - Running setup.py (path:/tmp/pip-dGRPOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:06 INFO - Running setup.py (path:/tmp/pip-HN7qfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:06 INFO - Running setup.py (path:/tmp/pip-iK1ync-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:07 INFO - Running setup.py (path:/tmp/pip-hsQwbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:07 INFO - Running setup.py (path:/tmp/pip-BxKW0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:07 INFO - Running setup.py (path:/tmp/pip-ZztN9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:07 INFO - Running setup.py (path:/tmp/pip-lpV4y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:07 INFO - Running setup.py (path:/tmp/pip-U7TcIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:30:07 INFO - Running setup.py install for manifestparser 08:30:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:30:07 INFO - Running setup.py install for mozcrash 08:30:07 INFO - Running setup.py install for mozdebug 08:30:07 INFO - Running setup.py install for mozdevice 08:30:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:30:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:30:07 INFO - Running setup.py install for mozfile 08:30:07 INFO - Running setup.py install for mozhttpd 08:30:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozinfo 08:30:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozInstall 08:30:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozleak 08:30:08 INFO - Running setup.py install for mozlog 08:30:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for moznetwork 08:30:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozprocess 08:30:08 INFO - Running setup.py install for mozprofile 08:30:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozrunner 08:30:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:30:08 INFO - Running setup.py install for mozscreenshot 08:30:08 INFO - Running setup.py install for moztest 08:30:09 INFO - Running setup.py install for mozversion 08:30:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:30:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:30:09 INFO - Cleaning up... 08:30:09 INFO - Return code: 0 08:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:09 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')]} 08:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:09 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')]} 08:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:09 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 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:30:09 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 08:30:09 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 08:30:09 INFO - Using env: {'DISPLAY': ':0', 08:30:09 INFO - 'HOME': '/home/cltbld', 08:30:09 INFO - 'LANG': 'en_US.UTF-8', 08:30:09 INFO - 'LANGUAGE': 'en_US:en', 08:30:09 INFO - 'LOGNAME': 'cltbld', 08:30:09 INFO - 'MAIL': '/var/mail/cltbld', 08:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:09 INFO - 'MOZ_NO_REMOTE': '1', 08:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:09 INFO - 'NO_EM_RESTART': '1', 08:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:09 INFO - 'PWD': '/builds/slave/test', 08:30:09 INFO - 'SHELL': '/bin/bash', 08:30:09 INFO - 'SHLVL': '1', 08:30:09 INFO - 'TERM': 'linux', 08:30:09 INFO - 'TMOUT': '86400', 08:30:09 INFO - 'USER': 'cltbld', 08:30:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:09 INFO - '_': '/tools/buildbot/bin/python'} 08:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:09 INFO - Running setup.py (path:/tmp/pip-zGfNIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:09 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)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:09 INFO - Running setup.py (path:/tmp/pip-UmoRPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:09 INFO - Running setup.py (path:/tmp/pip-Fi9Rvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:09 INFO - Running setup.py (path:/tmp/pip-8wt_MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:09 INFO - Running setup.py (path:/tmp/pip-va4xfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:09 INFO - Running setup.py (path:/tmp/pip-k4qsve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:09 INFO - Running setup.py (path:/tmp/pip-Y0yW1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:09 INFO - Running setup.py (path:/tmp/pip-MuF6Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:09 INFO - Running setup.py (path:/tmp/pip-ei1Rjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:10 INFO - Running setup.py (path:/tmp/pip-ngz8wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:10 INFO - Running setup.py (path:/tmp/pip-Drs5sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:10 INFO - Running setup.py (path:/tmp/pip-6Y3R8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:10 INFO - Running setup.py (path:/tmp/pip-kr5nkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:10 INFO - Running setup.py (path:/tmp/pip-D7w5pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:10 INFO - Running setup.py (path:/tmp/pip-hxj3Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:10 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)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:10 INFO - Running setup.py (path:/tmp/pip-9fJdbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:10 INFO - Running setup.py (path:/tmp/pip-B6vsJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30:12 INFO - Downloading blessings-1.6.tar.gz 08:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:30:12 INFO - Installing collected packages: blessings 08:30:12 INFO - Running setup.py install for blessings 08:30:12 INFO - Successfully installed blessings 08:30:12 INFO - Cleaning up... 08:30:12 INFO - Return code: 0 08:30:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:30:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:12 INFO - Reading from file tmpfile_stdout 08:30:12 INFO - Current package versions: 08:30:12 INFO - argparse == 1.2.1 08:30:12 INFO - blessings == 1.6 08:30:12 INFO - blobuploader == 1.2.4 08:30:12 INFO - docopt == 0.6.1 08:30:12 INFO - functools32 == 3.2.3-2 08:30:12 INFO - jsonschema == 2.5.1 08:30:12 INFO - manifestparser == 1.1 08:30:12 INFO - mozInstall == 1.12 08:30:12 INFO - mozcrash == 0.17 08:30:12 INFO - mozdebug == 0.1 08:30:12 INFO - mozdevice == 0.48 08:30:12 INFO - mozfile == 1.2 08:30:12 INFO - mozhttpd == 0.7 08:30:12 INFO - mozinfo == 0.9 08:30:12 INFO - mozleak == 0.1 08:30:12 INFO - mozlog == 3.3 08:30:12 INFO - moznetwork == 0.27 08:30:12 INFO - mozprocess == 0.23 08:30:12 INFO - mozprofile == 0.28 08:30:12 INFO - mozrunner == 6.12 08:30:12 INFO - mozscreenshot == 0.1 08:30:12 INFO - mozsystemmonitor == 0.3 08:30:12 INFO - moztest == 0.7 08:30:12 INFO - mozversion == 1.4 08:30:12 INFO - psutil == 3.1.1 08:30:12 INFO - requests == 1.2.3 08:30:12 INFO - wsgiref == 0.1.2 08:30:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:12 INFO - Using env: {'DISPLAY': ':0', 08:30:12 INFO - 'HOME': '/home/cltbld', 08:30:12 INFO - 'LANG': 'en_US.UTF-8', 08:30:12 INFO - 'LANGUAGE': 'en_US:en', 08:30:12 INFO - 'LOGNAME': 'cltbld', 08:30:12 INFO - 'MAIL': '/var/mail/cltbld', 08:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:12 INFO - 'MOZ_NO_REMOTE': '1', 08:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:12 INFO - 'NO_EM_RESTART': '1', 08:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:12 INFO - 'PWD': '/builds/slave/test', 08:30:12 INFO - 'SHELL': '/bin/bash', 08:30:12 INFO - 'SHLVL': '1', 08:30:12 INFO - 'TERM': 'linux', 08:30:12 INFO - 'TMOUT': '86400', 08:30:12 INFO - 'USER': 'cltbld', 08:30:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:12 INFO - '_': '/tools/buildbot/bin/python'} 08:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 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)) 08:30:13 INFO - Cleaning up... 08:30:13 INFO - Return code: 0 08:30:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c5a55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1400230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, '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': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', '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 08:30: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', 'jsonschema'] in /builds/slave/test/build 08:30: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 jsonschema 08:30:13 INFO - Using env: {'DISPLAY': ':0', 08:30:13 INFO - 'HOME': '/home/cltbld', 08:30:13 INFO - 'LANG': 'en_US.UTF-8', 08:30:13 INFO - 'LANGUAGE': 'en_US:en', 08:30:13 INFO - 'LOGNAME': 'cltbld', 08:30:13 INFO - 'MAIL': '/var/mail/cltbld', 08:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:13 INFO - 'MOZ_NO_REMOTE': '1', 08:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:13 INFO - 'NO_EM_RESTART': '1', 08:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:13 INFO - 'PWD': '/builds/slave/test', 08:30:13 INFO - 'SHELL': '/bin/bash', 08:30:13 INFO - 'SHLVL': '1', 08:30:13 INFO - 'TERM': 'linux', 08:30:13 INFO - 'TMOUT': '86400', 08:30:13 INFO - 'USER': 'cltbld', 08:30:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:13 INFO - '_': '/tools/buildbot/bin/python'} 08:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:30:13 INFO - Cleaning up... 08:30:13 INFO - Return code: 0 08:30:13 INFO - Running post-action listener: _resource_record_post_action 08:30:13 INFO - Running post-action listener: _start_resource_monitoring 08:30:13 INFO - Starting resource monitoring. 08:30:13 INFO - [mozharness: 2016-08-19 15:30:13.455281Z] Finished create-virtualenv step (success) 08:30:13 INFO - [mozharness: 2016-08-19 15:30:13.455853Z] Running install step. 08:30:13 INFO - Running pre-action listener: _resource_record_pre_action 08:30:13 INFO - Running main action method: install 08:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:13 INFO - Reading from file tmpfile_stdout 08:30:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:30:13 INFO - Reading from file tmpfile_stdout 08:30:13 INFO - Output received: 08:30:13 INFO - Usage: mozinstall [options] installer 08:30:13 INFO - Options: 08:30:13 INFO - -h, --help show this help message and exit 08:30:13 INFO - -d DEST, --destination=DEST 08:30:13 INFO - Directory to install application into. [default: 08:30:13 INFO - "/builds/slave/test"] 08:30:13 INFO - --app=APP Application being installed. [default: firefox] 08:30:13 INFO - mkdir: /builds/slave/test/build/application 08:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:30:29 INFO - Reading from file tmpfile_stdout 08:30:29 INFO - Output received: 08:30:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:30:29 INFO - Running post-action listener: _resource_record_post_action 08:30:29 INFO - [mozharness: 2016-08-19 15:30:29.830516Z] Finished install step (success) 08:30:29 INFO - [mozharness: 2016-08-19 15:30:29.830764Z] Running run-tests step. 08:30:29 INFO - Running pre-action listener: _resource_record_pre_action 08:30:29 INFO - Running main action method: run_tests 08:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:30:29 INFO - Python 2.7.3 08:30:29 INFO - Return code: 0 08:30:29 INFO - grabbing minidump binary from tooltool 08:30: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')]} 08:30:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fa090>, '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 0x13fd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fde40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:30:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:30:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:30:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:30:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:29 INFO - Return code: 0 08:30:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:30:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:30:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:30:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:30:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 08:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 08:30:29 INFO - Using env: {'DISPLAY': ':0', 08:30:29 INFO - 'HOME': '/home/cltbld', 08:30:29 INFO - 'LANG': 'en_US.UTF-8', 08:30:29 INFO - 'LANGUAGE': 'en_US:en', 08:30:29 INFO - 'LOGNAME': 'cltbld', 08:30:29 INFO - 'MAIL': '/var/mail/cltbld', 08:30:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:30:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:29 INFO - 'MOZ_NO_REMOTE': '1', 08:30:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:29 INFO - 'NO_EM_RESTART': '1', 08:30:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:29 INFO - 'PWD': '/builds/slave/test', 08:30:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:30:29 INFO - 'SHELL': '/bin/bash', 08:30:29 INFO - 'SHLVL': '1', 08:30:29 INFO - 'TERM': 'linux', 08:30:29 INFO - 'TMOUT': '86400', 08:30:29 INFO - 'USER': 'cltbld', 08:30:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119', 08:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:29 INFO - '_': '/tools/buildbot/bin/python'} 08:30:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 08:30:30 INFO - mozversion application_buildid: 20160819071321 08:30:30 INFO - mozversion application_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 08:30:30 INFO - mozversion application_display_name: Nightly 08:30:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:30 INFO - mozversion application_name: Firefox 08:30:30 INFO - mozversion application_remotingname: firefox 08:30:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:30:30 INFO - mozversion application_vendor: Mozilla 08:30:30 INFO - mozversion application_version: 51.0a1 08:30:30 INFO - mozversion platform_buildid: 20160819071321 08:30:30 INFO - mozversion platform_changeset: 23c2ec5544b9e0a74a047b87b594e4c36a8fe95c 08:30:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:30:30 INFO - mozversion platform_version: 51.0a1 08:30:30 INFO - using testdate: 1471620630 08:30:30 INFO - actual date: 1471620630 08:30:30 INFO - starting webserver on 'localhost:36864' 08:30:30 INFO - SUITE-START | Running 2 tests 08:30:30 INFO - TEST-START | dromaeo_css 08:30:30 INFO - operating with platform_type : linux_ 08:30:30 INFO - Initialising browser for dromaeo_css test... 08:30:30 INFO - TEST-INFO | started process 26649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL8Iyv4/profile http://localhost:36864/getInfo.html) 08:30:34 INFO - PROCESS | 26649 | __metrics Screen width/height:1600/1200 08:30:34 INFO - PROCESS | 26649 | colorDepth:24 08:30:34 INFO - PROCESS | 26649 | Browser inner width/height: 1024/697 08:30:34 INFO - PROCESS | 26649 | __metrics 08:30:35 INFO - PROCESS | 26649 | 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" 08:30:35 INFO - PROCESS | 26649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:35 INFO - PROCESS | 26649 | console.error: PushService: 08:30:35 INFO - PROCESS | 26649 | stateChangeProcessEnqueue: Error transitioning state 08:30:35 INFO - PROCESS | 26649 | UnknownError 08:30:36 INFO - TEST-INFO | 26649: exit 0 08:30:36 INFO - Browser initialized. 08:30:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:36 INFO - TEST-INFO | started process 26732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL8Iyv4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:48 INFO - PROCESS | 26732 | RSS: Main: 157208576 08:30:48 INFO - PROCESS | 26732 | 08:31:40 INFO - PROCESS | 26732 | 1471620700038 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] 08:33:51 INFO - PROCESS | 26732 | Cycle 1(1): loaded http://localhost:36864/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36864/tests/dromaeo/cssquery-ext.html) 08:33:52 INFO - PROCESS | 26732 | RSS: Main: 247345152 08:33:52 INFO - PROCESS | 26732 | 08:36:55 INFO - PROCESS | 26732 | Cycle 1(1): loaded http://localhost:36864/tests/dromaeo/cssquery-ext.html (next: http://localhost:36864/tests/dromaeo/cssquery-jquery.html) 08:36:56 INFO - PROCESS | 26732 | RSS: Main: 246124544 08:36:56 INFO - PROCESS | 26732 | 08:39:58 INFO - PROCESS | 26732 | Cycle 1(1): loaded http://localhost:36864/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36864/tests/dromaeo/cssquery-mootools.html) 08:39:58 INFO - PROCESS | 26732 | RSS: Main: 224309248 08:39:58 INFO - PROCESS | 26732 | 08:43:01 INFO - PROCESS | 26732 | Cycle 1(1): loaded http://localhost:36864/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36864/tests/dromaeo/cssquery-prototype.html) 08:43:01 INFO - PROCESS | 26732 | RSS: Main: 187768832 08:43:01 INFO - PROCESS | 26732 | 08:46:05 INFO - PROCESS | 26732 | Cycle 1(1): loaded http://localhost:36864/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36864/tests/dromaeo/cssquery-yui.html) 08:46:05 INFO - PROCESS | 26732 | RSS: Main: 188772352 08:46:05 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | Cycle 1(1): loaded http://localhost:36864/tests/dromaeo/cssquery-yui.html (next: http://localhost:36864/tests/dromaeo/cssquery-dojo.html) 08:49:08 INFO - PROCESS | 26732 | RSS: Main: 279035904 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | __start_tp_report 08:49:08 INFO - PROCESS | 26732 | _x_x_mozilla_page_load 08:49:08 INFO - PROCESS | 26732 | _x_x_mozilla_page_load_details 08:49:08 INFO - PROCESS | 26732 | |i|pagename|runs| 08:49:08 INFO - PROCESS | 26732 | |0;dojo.html;2578.780803631691;2590.9870450647745;2600.8959641614338;2607.6479675243836;2611.268844723477;4588.220002599558;4676.205045142326;4690.6951048181845;4757.119932812428;4761.214399624062;4707.62339012879;4725.480197178307;4758.571728544431;4765.8570242892765;4824.831130910419;4134.37984302354;4351.760653164082;4404.031113155101;4416.58042485965;4424.889377765549;4393.604575588196;4412.338149277602;4433.756143412111;4445.51099379068;4454.910901781963;4154.335306350969;4228.429162063144;4265.317549192146;4310.504292006397;4340.9565904341025;4372.27857403528;4372.475302963665;4373.693841431101;4378.10248898975;4384.956150438518;4335.349697545394;4336.262835318003;4357.7821108944745;4357.869263922087;4368.606825385698;4616.8153273869;4647.326137710047;4667.13657973276;4676.859694209179;4762.690425122356;5054.671446355975;5058.898822023539;5063.367079115111;5063.670861393997;5063.696178229281;5090.134677104901;5096.362954630671;5107.3360463139925;5109.156989096832;5112.079825631385;4594.563516465931;4677.7193368398;4742.146413645542;4743.83396581118;4748.477667456577;5238.869028274247;5241.68549887008;5250.343707036621;5251.973740131275;5252.133397989365;5019.29729837823;5027.4721154279005;5030.622703297267;5034.974825125851;5036.017976494549;4843.830465933675;4926.901461970812;4990.525900039491;4991.825286114969;5104.259882317043;4985.202367621163;5016.0971025215085;5020.723860187724;5021.974890125526;5024.723640199751;4968.677035992721;4982.202847544376;4986.276989836453;4988.201887697951;4990.30135780991;4120.526139493996;4222.683298752606;4233.70364074518;4254.532001479834;4261.595148460891;3728.5712143103347;3737.289914916157;3738.794366309879;3741.1956429367274;3756.8309426075893;4374.1786547676575;4380.518143004267;4382.342648602671;4392.736435813861;4393.604575588212;4934.8766280843265;5027.396712394536;5027.874303142377;5093.286939828427;5132.5124113209185;4364.388985542027;4388.27593447084;4391.341298805205;4393.297072468454;4394.780260986938;4609.562091601292;4611.216093264086;4612.723236605747;4616.60758835496;4624.237000894882;4587;4698.530146985274;4743.667943244078;4754.4532378776885;4793.846614889008;5069.7465126744255;5083.517065878736;5095.184770436712;5100.617453690914;5100.668456550312;4794.760261986817;4801.975990120027;4802.903941921212;4805.0149719306755;4806.8077276909935;4831.879203019953;4940.901181976268;4975.5522003019905;4999.825006124768;5030.195168772979;5123.231515272739;5126.128558145049;5131.769070391767;5138.306328645585;5144.30551875492;5006.524380183877;5014.17266151081;5018.749062546931;5018.7741551631;5025.874353141201;4772.546608072227;4870.853874383774;4905.656604037683;4935.037667654917;4988.326575912351;4899.534544218293;4909.9263511048075;4927.211646136601;4933.33399991011;4939.185034469272;5018.272350509083;5018.84943451697;5027.195648696191;5030.647854650139;5030.798768049237;4772.928406073981;4784.449788274393;4836.927446088241;4846.273059041172;4914.631402644744 08:49:08 INFO - PROCESS | 26732 | |1;ext.html;548.9698066606336;566.7308028686377;568.8975984322822;571.45997032804;579.5942840011993;28286.43427131459;38681.80659096704;40066.399004014966;40422.39366409503;44238.33642495357;40001.599984000226;40335.79832100843;40397.596024039754;40466.797666011706;40475.392869106916;7613.847723045522;7738.303552680258;7762.7671169865;7769.0677118745825;7776;7745.225477452238;7831.490953088031;7843.921560784376;7863.8034049148655;7865.370770338359;7842.803929901741;7854.410919181056;7887.723929662463;7890.250426209501;7897.447178697494;7812.453128281023;7817.843643127106;7864.921350786476;7879.448438609328;7885.842283154362;7726.961365193194;7777.688892444296;7778.261065198797;7786.961065194694;7791.181925897756;37308;37533.62466375329;37539.249215015545;37561;37720.62279377199;2946.764258859286;3166.224275052604;3194.6166460024947;3274.885379011747;3562.0560551453887;28721.28196795076;28909.855450722822;29436.705632943824;29655.25861853449;30653.846730766425;3271.574695289621;3330.58367704037;3341.5488908997218;3359.1937934895695;3480.251745874624;252189;254320;254328;254555.72722136456;255119;44465.773831841216;46138.538614613426;50846.23730644043;51067.48932510702;51144.74427627838;52037.73981130146;53279.46720532823;53535.19697204545;58257.70871145617;58469;12451.128421010624;12553.497860085494;12556.121071524905;12556.686082848002;12563.93718031404;9857.457839818735;9945.353552019096;9947.80104397908;9954.601815927426;9956.651517196864;13929.303534823219;14255.572332830032;14271.857281427261;14764.852351476347;15212.619684507754;5872.295324560994;5965.433283838029;6066.302375226817;6081.8479538011015;6145.310039739107;785.8860465232509;858.9012263589642;872.3326655108847;923.1507013547553;977.027857282009;27272;27636.58545121825;28115.71884281172;28232;28238.576421353697;879.4591326334386;893.6693423433371;941.7975135345933;989.188865130586;1024.2164743970868;13708.45166193361;14817.259137043106;14907;14978.700425991638;15211.619709507351;364665;367071;368914;369668;370550;49288;49310;49355.75322123367;49365.50634493609;49461.25808112881;1126.52122847791;1166.055495049013;1173.8650055243756;1175.482787573465;1177.6290468502393;25873.22380328593;27033.86483067572;27104.864475677496;27738.44523109486;27905;42399;42781.57218427776;42841.78579107209;42863.35704964366;42883.356749648156;292777.3306069829;293060;293694;294902;297844;34559.308813824086;35997.82001089978;36724;36724.44913326356;36729.63270367262;40838.68530411844;41014;41437.378439322834;42380.15239695127;42416.787916060224;34561.48157777686;34903;35151.47272790859;35268;35366.115847103;35032.82483587566;35319.47020794639;35611;35621;35758.46362304516;34713.82643086768;35071.47392789059;35291;35683.643163568035;35867.10332241611;29292;32131.678683212867;32464.350712985135;32531;32588;24035.399115021566;24206.515869682156;24478;24639.137630182857;24935.501289973738 08:49:08 INFO - PROCESS | 26732 | |2;jquery.html;351.28688761813527;366.74144727966785;371.5207382476605;378.8257401595266;387.96120387961207;12504.249745015293;16101.838981610195;16154.757678634815;17244.741328880045;17398.739018914726;14157.646058848533;14307.570772876805;14384.424623015093;14493.78259326111;14512.709745805105;4425.291953287475;4959.429665588449;5146.845594632167;5184.922226166611;5186.7925282988635;4983.352164218646;5051.722155281458;5056.570191533724;5058.772355244023;5060.822871199509;4817.325574419584;4998.625103117262;5021.472745361739;5031.195008798593;5034.647574669774;5016.774245158977;5058.873528161807;5061.240813877911;5062.974685126551;5063.696178229299;4458.9554104459185;4493.618042466394;4553.726776393394;4565.269556870885;4567.310095264774;20385.592288154156;20574.897125514275;20754.79245207544;21084.683729744065;21088.578228435497;1829.4968883556994;2043.4686981384798;2099.8215151712125;2349.3569734049192;2455.1652438170927;12939.353032348345;13133.488900855542;13237.139585926883;13520.32398380077;13906.721865562733;1718.9312427502884;1774.3168879981172;1805.2508209093342;1810.339226182434;1811.6195598924241;64490.355096448904;66603;67172;67936.32063679399;68493.31506684919;8556.572171391406;9001.864972025425;9806.31355805101;9863.457509836884;10083.697489075339;13461.528846490326;13467.663308417172;13482.123661961941;13496.730065398637;13527.188368697909;6780.050792888999;6871.725130994804;6981.30186981308;7128.465365097639;7128.857422851514;6367.204099487564;6435.485161187187;6578.80263592093;6593.011048342787;6605.108310378134;6041.154238406627;6073.331933487313;6102.237220347457;6120.724567394478;6368.732948924232;1723.2417736196035;1758.9824101759075;1776.644671065792;1792.2382987230376;1794.5154808201712;790.2887401338841;828.8010877389383;929.3076657889916;949.3449519831295;960.9663661771805;16682.582935426468;16791.412300569667;17631.382901598638;17832.3758668446;18194.727079093824;809.9433039687283;844.8141408890034;888.6583851551209;891.3582220801013;905.6046756329603;9560.56977436017;10043.69868903934;10216.591336346612;10239.59041638341;10249.282550221562;362819;366672;368869;379038;380065;48177.277340839915;67806;68081.3191868075;68407.65796170988;70640.64679676671;925.2274350916925;930.5161316115582;945.716285114463;970.3935040599625;979.7991411760572;11221;15399.3070311834;16299.674006520041;16551;16587.585310366856;28265.858670706515;34727;34903;35873;36829.44755828611;41337.93310334531;41821.372679410444;41914;43663.781681091394;44207.778961106276;7273.9636301818155;7444.776656700307;7491.887621685788;7536.397088233038;7568.470207085451;5531.778728850801;6414.743410263537;10918.672439826818;11540.365279909685;11794.997425218953;9921.454320012468;10151.390916545031;10434.321769084985;10542.103921166787;10679.679609611723;10003.749906252402;10059.748506287402;10085;10323.690289291333;10489.055984961391;9853.359531630707;10585.153187745116;10598.20513461509;10719.088877445505;10767.246292759744;7612.923870761443;7634.427417943787;7801.258880406353;7843;8036.799080023046;9680.370775899544;10335.17318614494;10348.793024139626;10432.895671043192;10729 08:49:08 INFO - PROCESS | 26732 | |3;mootools.html;1355.0920883008387;1356.1862882270639;1439.316324745746;1613.749868770341;1659.8755093368;7169.462290328227;7679.078510578732;7758.534487930714;7771.650275737584;7784.338331241851;6597.779410808992;7109.075820143387;7362.190159082496;7396.630168491567;7575.734849280277;2149.258505815491;2173.9456513587206;2177.4882902517897;2183.0394626364427;2194.47332640166;2109.3144727963395;2144.356692992104;2184.1263494602126;2188.6498160294354;2193.1008286602496;2145.4529095080734;2145.5387091775265;2149.7742737012622;2160.902759375824;2178.1505212966954;2151.451379898124;2154.806067453921;2159.4709296222527;2160.9783902161093;2161.686555449451;2105.6841473778904;2126.2876936226385;2126.7873212678765;2128.17001369466;2132.637451633226;7396.408287337;7486.812829679302;7521.285477879593;7529.360004399633;7535.058117735283;4134.276501612206;4255.361695745632;4256.489221293465;4258.190943720683;4263.552327005651;2697.5953606958915;2788.2332358601343;2808.8033837631374;2811.4236581500745;2814.620026296465;851.3699862102062;892.1078921078921;910.4491782471641;912.1653686876566;913.7943962608426;10336.121429678486;10340.534675939602;10377.429241391721;10395.636152734694;10417.843732344021;3907.394353875097;4079.755674519241;4163.8334466621;4200.684948628804;4207.97896010518;8793.076726943578;8826.911730882737;8830.381873268809;8849.070847561043;8861.512616806009;4252.808623611945;4289.206496798102;4293.656507479394;4298.742075475481;4305.160493703697;3430.8456119474686;3782.7730336179366;3855.383138697795;3860.9227815443533;3908.2769687607883;3516.0682419158943;3528.4707293906117;3654.9634503654624;3658.926821463609;3671.1189314564313;1140.5836869542557;1180.1797750563276;1180.7933611617932;1183.1244878789635;1183.4260383713893;812.4353574265829;830.0150866866197;846.9830603387898;849.1041950742026;857.566928701002;5005.295022678671;5037.697738135724;5153.819616313411;5213.244079608436;5241.9737901310245;360.37474980908104;374.49630247317316;376.57070939129414;389.5909295239987;393.3313367275643;3263.9673603264137;3293.670632936687;3309.1561651778643;3309.4539400999047;3451.3442445935193;8888.155625215593;9353.532323383804;9353.719388418358;9416;9418.95290523543;9269.536523173814;9308.534573271309;9319.021502742115;9324.766880827898;9325.114114159143;7042.823929401806;7119.893201601876;7120.430365570845;7134.500584959003;7136.892946605805;4848.200046992207;4862.197737373293;4898.681585696918;4952.083864485082;5151.433342332265;7960.2039796019935;8025.077116131486;8482.363822713198;8565.743027709179;8595.65617375323;8347.499150051017;8486.660533578835;8513.233808957224;8517.701880434402;8584.828303434022;5712.714364281853;6318.936810631835;6546.803595892131;6713.1944166700305;6717.630530320879;7095.254998225112;7359.264073592812;7375.8156046099275;7380.741674041383;7387.298206670358;6497.252815926229;6686.06395104676;6697.799066028027;6872.69072891711;6875.724971001104;6444.226692796894;6597.967010164918;6631.734730610914;6734.124563806674;6779.389854913082;5860.355360910382;5934.821955341346;5949.613275137102;5950.2264705587995;5953.28560572734;4375;4381.890452738707;4447.911041779211;4513.119941611354;4572.45130584332;4314.094040251583;4336.674749393871;4390.736555806662;4443.666724995703;4489.438820147481 08:49:08 INFO - PROCESS | 26732 | |4;prototype.html;289.60179752839844;301.3686327144631;302.09974276655566;309.0758631691244;309.5666067505492;4852.9514704852945;4878.609711223103;4881.24340727187;4885.609151267899;4886.780094895729;4751.501092385293;4817.108834865552;4820.325154478376;4822.517748225176;4826.444958829736;3595.8561657533733;3726.9813650931706;3736.897615203508;3741.7380783345175;3741.9625803741887;3631.654992775682;3755.929560075379;3778.8866334009886;3807.714421418391;3844.1735026969195;3743;3754.1177823211524;3768.4939515222345;3795.5139383703718;3801.6388443097862;3508.5263489428858;3684.6551008881834;3730.3844865597143;3733.7759734415886;3751.6623503884507;3238.2228265216413;3243.2054146733967;3247.951280730791;3255.137388592001;3258.804471731704;4658.417697787777;4685.390899183084;4689.921318096823;4699;4704.694194877322;4200.85297014603;4229.302165142748;4241.639460645818;4244.469441319835;4257.233697934371;4776.904461910777;4940;5010.248462730583;5035.622328325354;5039.823606173803;3573.3032058748554;3578.910527236814;3581.803000834953;3584.2652256287397;3597.334493118781;5258.605604579634;5270.20812923604;5278.498542638443;5282.947170528284;5284.837335786121;3541.327147841902;3638.399664055454;3649.361361761681;3650.1969566695284;3657.5976642569294;3636.381815091441;3646.872359467459;3647.544056992876;3660.158163622382;3697.3344797936093;4181.790910454526;4195.370694395804;4200.172924777731;4202.642775364067;4204.873853784391;4983.0033993201505;4999.250412273235;5009.699418034929;5025.84922452327;5029.748512574357;1207.6980754811298;1261.0857128581888;1271.0721173543366;1271.8807449444614;1273.3124112979074;801.410962942237;811.9675212991532;825.2407784837964;828.0684230240979;838.3000194837379;4240;4293.69944103916;4357.169988604794;4395.428594282723;4426.911461770811;5125.923111153335;5138.97430512845;5155.458676838953;5158.277841102249;5185.170372740419;4414.55854414556;4423.380726698265;4444.755538445416;4445.687962467982;4452.599266066005;2643.4845205184806;2721.7550420462253;2747.519184142807;2750.80340052078;2758.2828464599347;4836.153673107192;4882.926756098661;4887.706737595756;4888.682235654742;4893.412790465096;5087.465816089331;5269.601107285779;5287.550558202519;5295.258663787073;5307.177387504943;4862.246351815475;4874.463808981081;4884.853454396374;4888.364512613338;4899.3385892904;5152.613553983391;5167.870803229949;5170.44063188709;5171.896562068813;5184.585233181261;4807;5086.7710953007945;5087.481696560227;5097.617678674188;5099.286099945936;4909.618834865016;4923.335349727741;4927.630427718007;4928.486471899286;4947.455779864284;3645.289168612095;3654.3970244910356;3663.835127419326;3695.9651297636706;3701.7408781385043;5025.7916784127065;5261.3686357637325;5262.8947920937035;5267.631265811357;5283.920741188808;5043.193089105725;5043.4365346742625;5049.2173713074535;5063.164577844762;5110.974445127899;5023.212117274948;5038.924416133834;5076;5085.872853178552;5089.465606111453;4724.6692731508465;4997.225430058346;4999.400071991385;5016.473270306566;5020.874478138076;4836.678394370651;4906.63200259989;5043.84868453947;5091.898162036812;5109.335786347751;4904.2835007747;4947.950520494749;4952.47998960104;4952.8018879245865;4971.130052240771 08:49:08 INFO - PROCESS | 26732 | |5;yui.html;576.1357963055417;606.557213234339;606.8604221029163;675.3347952267017;677.1975209376888;12800.679983000418;13522.459101635935;13596.388162532685;13615.183089014667;13663.521776737816;13357.198568085922;13434.126781759178;13552.932235338809;13637.659058523543;13650.38573264203;623.5853157650157;746.8506298740247;752.0636807175075;772.4129661457276;774.0943096577018;761.6534476813036;771.949823261489;774.4501404003164;774.5159275452842;774.7946794099568;831.0069466986923;831.9500829950223;832.4713806732738;832.6128350317101;832.6669332267081;659.8416380068797;788.2157253532772;808.8220591469867;830.1325115254574;832.7626626411444;590.5187272373003;590.6220019187723;592.0586267834165;592.3188333416606;592.6177615438019;13435.865641343558;13475.932620336933;13496.5276215332;13500.86499135006;13518.662033449242;12423.627291181188;12834.743305133938;13441.932790336083;13649.863501364958;13681.863181368159;12023.939880300542;12198.817017744741;12222.816657750142;12312.753744925052;12507.562235321811;4146.170765846812;4153.6677065834965;4166.375043743433;4188.748675079474;4262.424572682679;62691.373086269465;62875;63793;63794.36205637931;64687.353126469076;10646.574137034588;10783.245172837826;10837.783244335069;10958.068564171976;11364.261323014143;19477.318293859647;19487;19494.707579386322;19525.902370488056;19531.609367812565;6847.21257055435;6874.415674667609;6896.103506544217;7211.639418029183;7232.312930271616;3670.8164591770305;3752.3620984432714;3783.3000894834545;3822.4648549203134;3907.6873850091924;2790.525610646195;2904.9854750726536;2908.9709102909123;2911.6360454943133;2912.941741165165;497.8929530150962;501.93725784276967;507.1834346701807;512.4977522028433;519.1045446604577;474.632160075937;487.39319547164007;490.83311674030284;500.7471227030399;507.7393276151026;7216.314450127229;7347.08161479815;7393.482456228013;7663.808404789925;7971;464.93955785747636;498.6783524626596;529.9046171689133;534.3214118070107;558.040170906041;3395.864165433404;3436.0722604896537;3437.7077948374167;3442.1738782691973;3447.2246792901674;95118;97001.514992426;98703.50648246713;100409.49795250977;101319.49340253399;49605.751971239915;84055;87160.56419717988;87277.56361218153;90365;74670.62664686641;76810.23189768143;77420.61289693516;77920;78523;6390.424861762278;6704.882229763183;6795.388415042472;6972.302769722987;7063.399611032914;44949;46473.302900457194;46517.53482465132;47085.29372059353;47131;59255.40744592499;63989.68005160131;66681.66659166673;67577.3242267571;69115;9045.185933266037;9205.861912071457;9322.766930826783;9660.806783864144;9788.265880059167;11074;11219.158563107636;11863.762724745284;12093.57672481459;12345.814812777995;7751.37988960893;10539.57841686324;10952.28810127371;11014.229003969966;11043.447827608748;11685.240459370114;11706.1220408468;11893.46479408446;12075.57735479254;12430.564930227398;11252.718682033015;11275.887241127812;11973.461194246105;12256;12386.071044671506;9419.952900235729;9582.90417095848;9710.514474276117;9787.755306117118;10056.994300570177;9529.857052144362;9695.321327507007;9844.852327215242;10004.799904001733;10023.298369114093 08:49:08 INFO - PROCESS | 26732 | __end_tp_report 08:49:08 INFO - PROCESS | 26732 | __start_cc_report 08:49:08 INFO - PROCESS | 26732 | _x_x_mozilla_cycle_collect,1042 08:49:08 INFO - PROCESS | 26732 | __end_cc_report 08:49:08 INFO - PROCESS | 26732 | __startTimestamp1471621748812__endTimestamp 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | ------- Summary: start ------- 08:49:08 INFO - PROCESS | 26732 | Number of tests: 6 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | [#0] dojo.html Cycles:165 Average:4677.85 Median:4794.76 stddev:501.25 (10.5%) stddev-sans-first:474.97 08:49:08 INFO - PROCESS | 26732 | Values: 2578.8 2591.0 2600.9 2607.6 2611.3 4588.2 4676.2 4690.7 4757.1 4761.2 4707.6 4725.5 4758.6 4765.9 4824.8 4134.4 4351.8 4404.0 4416.6 4424.9 4393.6 4412.3 4433.8 4445.5 4454.9 4154.3 4228.4 4265.3 4310.5 4341.0 4372.3 4372.5 4373.7 4378.1 4385.0 4335.3 4336.3 4357.8 4357.9 4368.6 4616.8 4647.3 4667.1 4676.9 4762.7 5054.7 5058.9 5063.4 5063.7 5063.7 5090.1 5096.4 5107.3 5109.2 5112.1 4594.6 4677.7 4742.1 4743.8 4748.5 5238.9 5241.7 5250.3 5252.0 5252.1 5019.3 5027.5 5030.6 5035.0 5036.0 4843.8 4926.9 4990.5 4991.8 5104.3 4985.2 5016.1 5020.7 5022.0 5024.7 4968.7 4982.2 4986.3 4988.2 4990.3 4120.5 4222.7 4233.7 4254.5 4261.6 3728.6 3737.3 3738.8 3741.2 3756.8 4374.2 4380.5 4382.3 4392.7 4393.6 4934.9 5027.4 5027.9 5093.3 5132.5 4364.4 4388.3 4391.3 4393.3 4394.8 4609.6 4611.2 4612.7 4616.6 4624.2 4587.0 4698.5 4743.7 4754.5 4793.8 5069.7 5083.5 5095.2 5100.6 5100.7 4794.8 4802.0 4802.9 4805.0 4806.8 4831.9 4940.9 4975.6 4999.8 5030.2 5123.2 5126.1 5131.8 5138.3 5144.3 5006.5 5014.2 5018.7 5018.8 5025.9 4772.5 4870.9 4905.7 4935.0 4988.3 4899.5 4909.9 4927.2 4933.3 4939.2 5018.3 5018.8 5027.2 5030.6 5030.8 4772.9 4784.4 4836.9 4846.3 4914.6 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | [#1] ext.html Cycles:180 Average:46116.21 Median:370109.00 stddev:81246.77 (22.0%) stddev-sans-first:81402.65 08:49:08 INFO - PROCESS | 26732 | Values: 549.0 566.7 568.9 571.5 579.6 28286.4 38681.8 40066.4 40422.4 44238.3 40001.6 40335.8 40397.6 40466.8 40475.4 7613.8 7738.3 7762.8 7769.1 7776.0 7745.2 7831.5 7843.9 7863.8 7865.4 7842.8 7854.4 7887.7 7890.3 7897.4 7812.5 7817.8 7864.9 7879.4 7885.8 7727.0 7777.7 7778.3 7787.0 7791.2 37308.0 37533.6 37539.2 37561.0 37720.6 2946.8 3166.2 3194.6 3274.9 3562.1 28721.3 28909.9 29436.7 29655.3 30653.8 3271.6 3330.6 3341.5 3359.2 3480.3 252189.0 254320.0 254328.0 254555.7 255119.0 44465.8 46138.5 50846.2 51067.5 51144.7 52037.7 53279.5 53535.2 58257.7 58469.0 12451.1 12553.5 12556.1 12556.7 12563.9 9857.5 9945.4 9947.8 9954.6 9956.7 13929.3 14255.6 14271.9 14764.9 15212.6 5872.3 5965.4 6066.3 6081.8 6145.3 785.9 858.9 872.3 923.2 977.0 27272.0 27636.6 28115.7 28232.0 28238.6 879.5 893.7 941.8 989.2 1024.2 13708.5 14817.3 14907.0 14978.7 15211.6 364665.0 367071.0 368914.0 369668.0 370550.0 49288.0 49310.0 49355.8 49365.5 49461.3 1126.5 1166.1 1173.9 1175.5 1177.6 25873.2 27033.9 27104.9 27738.4 27905.0 42399.0 42781.6 42841.8 42863.4 42883.4 292777.3 293060.0 293694.0 294902.0 297844.0 34559.3 35997.8 36724.0 36724.4 36729.6 40838.7 41014.0 41437.4 42380.2 42416.8 34561.5 34903.0 35151.5 35268.0 35366.1 35032.8 35319.5 35611.0 35621.0 35758.5 34713.8 35071.5 35291.0 35683.6 35867.1 29292.0 32131.7 32464.4 32531.0 32588.0 24035.4 24206.5 24478.0 24639.1 24935.5 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | [#2] jquery.html Cycles:180 Average:23017.66 Median:41579.65 stddev:61084.61 (146.9%) stddev-sans-first:61232.26 08:49:08 INFO - PROCESS | 26732 | Values: 351.3 366.7 371.5 378.8 388.0 12504.2 16101.8 16154.8 17244.7 17398.7 14157.6 14307.6 14384.4 14493.8 14512.7 4425.3 4959.4 5146.8 5184.9 5186.8 4983.4 5051.7 5056.6 5058.8 5060.8 4817.3 4998.6 5021.5 5031.2 5034.6 5016.8 5058.9 5061.2 5063.0 5063.7 4459.0 4493.6 4553.7 4565.3 4567.3 20385.6 20574.9 20754.8 21084.7 21088.6 1829.5 2043.5 2099.8 2349.4 2455.2 12939.4 13133.5 13237.1 13520.3 13906.7 1718.9 1774.3 1805.3 1810.3 1811.6 64490.4 66603.0 67172.0 67936.3 68493.3 8556.6 9001.9 9806.3 9863.5 10083.7 13461.5 13467.7 13482.1 13496.7 13527.2 6780.1 6871.7 6981.3 7128.5 7128.9 6367.2 6435.5 6578.8 6593.0 6605.1 6041.2 6073.3 6102.2 6120.7 6368.7 1723.2 1759.0 1776.6 1792.2 1794.5 790.3 828.8 929.3 949.3 961.0 16682.6 16791.4 17631.4 17832.4 18194.7 809.9 844.8 888.7 891.4 905.6 9560.6 10043.7 10216.6 10239.6 10249.3 362819.0 366672.0 368869.0 379038.0 380065.0 48177.3 67806.0 68081.3 68407.7 70640.6 925.2 930.5 945.7 970.4 979.8 11221.0 15399.3 16299.7 16551.0 16587.6 28265.9 34727.0 34903.0 35873.0 36829.4 41337.9 41821.4 41914.0 43663.8 44207.8 7274.0 7444.8 7491.9 7536.4 7568.5 5531.8 6414.7 10918.7 11540.4 11795.0 9921.5 10151.4 10434.3 10542.1 10679.7 10003.7 10059.7 10085.0 10323.7 10489.1 9853.4 10585.2 10598.2 10719.1 10767.2 7612.9 7634.4 7801.3 7843.0 8036.8 9680.4 10335.2 10348.8 10432.9 10729.0 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | [#3] mootools.html Cycles:180 Average:4935.26 Median:4855.20 stddev:2782.84 (57.3%) stddev-sans-first:2777.65 08:49:08 INFO - PROCESS | 26732 | Values: 1355.1 1356.2 1439.3 1613.7 1659.9 7169.5 7679.1 7758.5 7771.7 7784.3 6597.8 7109.1 7362.2 7396.6 7575.7 2149.3 2173.9 2177.5 2183.0 2194.5 2109.3 2144.4 2184.1 2188.6 2193.1 2145.5 2145.5 2149.8 2160.9 2178.2 2151.5 2154.8 2159.5 2161.0 2161.7 2105.7 2126.3 2126.8 2128.2 2132.6 7396.4 7486.8 7521.3 7529.4 7535.1 4134.3 4255.4 4256.5 4258.2 4263.6 2697.6 2788.2 2808.8 2811.4 2814.6 851.4 892.1 910.4 912.2 913.8 10336.1 10340.5 10377.4 10395.6 10417.8 3907.4 4079.8 4163.8 4200.7 4208.0 8793.1 8826.9 8830.4 8849.1 8861.5 4252.8 4289.2 4293.7 4298.7 4305.2 3430.8 3782.8 3855.4 3860.9 3908.3 3516.1 3528.5 3655.0 3658.9 3671.1 1140.6 1180.2 1180.8 1183.1 1183.4 812.4 830.0 847.0 849.1 857.6 5005.3 5037.7 5153.8 5213.2 5242.0 360.4 374.5 376.6 389.6 393.3 3264.0 3293.7 3309.2 3309.5 3451.3 8888.2 9353.5 9353.7 9416.0 9419.0 9269.5 9308.5 9319.0 9324.8 9325.1 7042.8 7119.9 7120.4 7134.5 7136.9 4848.2 4862.2 4898.7 4952.1 5151.4 7960.2 8025.1 8482.4 8565.7 8595.7 8347.5 8486.7 8513.2 8517.7 8584.8 5712.7 6318.9 6546.8 6713.2 6717.6 7095.3 7359.3 7375.8 7380.7 7387.3 6497.3 6686.1 6697.8 6872.7 6875.7 6444.2 6598.0 6631.7 6734.1 6779.4 5860.4 5934.8 5949.6 5950.2 5953.3 4375.0 4381.9 4447.9 4513.1 4572.5 4314.1 4336.7 4390.7 4443.7 4489.4 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | [#4] prototype.html Cycles:180 Average:4171.74 Median:4821.42 stddev:1222.49 (25.4%) stddev-sans-first:1190.69 08:49:08 INFO - PROCESS | 26732 | Values: 289.6 301.4 302.1 309.1 309.6 4853.0 4878.6 4881.2 4885.6 4886.8 4751.5 4817.1 4820.3 4822.5 4826.4 3595.9 3727.0 3736.9 3741.7 3742.0 3631.7 3755.9 3778.9 3807.7 3844.2 3743.0 3754.1 3768.5 3795.5 3801.6 3508.5 3684.7 3730.4 3733.8 3751.7 3238.2 3243.2 3248.0 3255.1 3258.8 4658.4 4685.4 4689.9 4699.0 4704.7 4200.9 4229.3 4241.6 4244.5 4257.2 4776.9 4940.0 5010.2 5035.6 5039.8 3573.3 3578.9 3581.8 3584.3 3597.3 5258.6 5270.2 5278.5 5282.9 5284.8 3541.3 3638.4 3649.4 3650.2 3657.6 3636.4 3646.9 3647.5 3660.2 3697.3 4181.8 4195.4 4200.2 4202.6 4204.9 4983.0 4999.3 5009.7 5025.8 5029.7 1207.7 1261.1 1271.1 1271.9 1273.3 801.4 812.0 825.2 828.1 838.3 4240.0 4293.7 4357.2 4395.4 4426.9 5125.9 5139.0 5155.5 5158.3 5185.2 4414.6 4423.4 4444.8 4445.7 4452.6 2643.5 2721.8 2747.5 2750.8 2758.3 4836.2 4882.9 4887.7 4888.7 4893.4 5087.5 5269.6 5287.6 5295.3 5307.2 4862.2 4874.5 4884.9 4888.4 4899.3 5152.6 5167.9 5170.4 5171.9 5184.6 4807.0 5086.8 5087.5 5097.6 5099.3 4909.6 4923.3 4927.6 4928.5 4947.5 3645.3 3654.4 3663.8 3696.0 3701.7 5025.8 5261.4 5262.9 5267.6 5283.9 5043.2 5043.4 5049.2 5063.2 5111.0 5023.2 5038.9 5076.0 5085.9 5089.5 4724.7 4997.2 4999.4 5016.5 5020.9 4836.7 4906.6 5043.8 5091.9 5109.3 4904.3 4948.0 4952.5 4952.8 4971.1 08:49:08 INFO - PROCESS | 26732 | 08:49:08 INFO - PROCESS | 26732 | [#5] yui.html Cycles:180 Average:17863.70 Median:499.71 stddev:25678.46 (5138.6%) stddev-sans-first:25717.69 08:49:08 INFO - PROCESS | 26732 | Values: 576.1 606.6 606.9 675.3 677.2 12800.7 13522.5 13596.4 13615.2 13663.5 13357.2 13434.1 13552.9 13637.7 13650.4 623.6 746.9 752.1 772.4 774.1 761.7 771.9 774.5 774.5 774.8 831.0 832.0 832.5 832.6 832.7 659.8 788.2 808.8 830.1 832.8 590.5 590.6 592.1 592.3 592.6 13435.9 13475.9 13496.5 13500.9 13518.7 12423.6 12834.7 13441.9 13649.9 13681.9 12023.9 12198.8 12222.8 12312.8 12507.6 4146.2 4153.7 4166.4 4188.7 4262.4 62691.4 62875.0 63793.0 63794.4 64687.4 10646.6 10783.2 10837.8 10958.1 11364.3 19477.3 19487.0 19494.7 19525.9 19531.6 6847.2 6874.4 6896.1 7211.6 7232.3 3670.8 3752.4 3783.3 3822.5 3907.7 2790.5 2905.0 2909.0 2911.6 2912.9 497.9 501.9 507.2 512.5 519.1 474.6 487.4 490.8 500.7 507.7 7216.3 7347.1 7393.5 7663.8 7971.0 464.9 498.7 529.9 534.3 558.0 3395.9 3436.1 3437.7 3442.2 3447.2 95118.0 97001.5 98703.5 100409.5 101319.5 49605.8 84055.0 87160.6 87277.6 90365.0 74670.6 76810.2 77420.6 77920.0 78523.0 6390.4 6704.9 6795.4 6972.3 7063.4 44949.0 46473.3 46517.5 47085.3 47131.0 59255.4 63989.7 66681.7 67577.3 69115.0 9045.2 9205.9 9322.8 9660.8 9788.3 11074.0 11219.2 11863.8 12093.6 12345.8 7751.4 10539.6 10952.3 11014.2 11043.4 11685.2 11706.1 11893.5 12075.6 12430.6 11252.7 11275.9 11973.5 12256.0 12386.1 9420.0 9582.9 9710.5 9787.8 10057.0 9529.9 9695.3 9844.9 10004.8 10023.3 08:49:08 INFO - PROCESS | 26732 | -------- Summary: end -------- 08:49:08 INFO - PROCESS | 26732 | 08:49:09 INFO - TEST-INFO | 26732: exit 0 08:49:09 INFO - TEST-OK | dromaeo_css | took 1119514ms 08:49:09 INFO - TEST-START | kraken 08:49:09 INFO - operating with platform_type : linux_ 08:49:09 INFO - Initialising browser for kraken test... 08:49:09 INFO - TEST-INFO | started process 27038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw9g08_/profile http://localhost:36864/getInfo.html) 08:49:14 INFO - PROCESS | 27038 | __metrics Screen width/height:1600/1200 08:49:14 INFO - PROCESS | 27038 | colorDepth:24 08:49:14 INFO - PROCESS | 27038 | Browser inner width/height: 1024/697 08:49:14 INFO - PROCESS | 27038 | __metrics 08:49:14 INFO - PROCESS | 27038 | 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" 08:49:14 INFO - PROCESS | 27038 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:15 INFO - PROCESS | 27038 | console.error: PushService: 08:49:15 INFO - PROCESS | 27038 | stateChangeProcessEnqueue: Error transitioning state 08:49:15 INFO - PROCESS | 27038 | UnknownError 08:49:15 INFO - TEST-INFO | 27038: exit 0 08:49:15 INFO - Browser initialized. 08:49:15 INFO - Running cycle 1/1 for kraken test... 08:49:15 INFO - TEST-INFO | started process 27119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw9g08_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:27 INFO - PROCESS | 27119 | RSS: Main: 157470720 08:49:27 INFO - PROCESS | 27119 | 08:49:30 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36864/tests/kraken/driver.html?testName=audio-beat-detection) 08:49:31 INFO - PROCESS | 27119 | RSS: Main: 212815872 08:49:31 INFO - PROCESS | 27119 | 08:49:34 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36864/tests/kraken/driver.html?testName=audio-dft) 08:49:34 INFO - PROCESS | 27119 | RSS: Main: 190636032 08:49:34 INFO - PROCESS | 27119 | 08:49:38 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36864/tests/kraken/driver.html?testName=audio-fft) 08:49:38 INFO - PROCESS | 27119 | RSS: Main: 270204928 08:49:38 INFO - PROCESS | 27119 | 08:49:40 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36864/tests/kraken/driver.html?testName=audio-oscillator) 08:49:41 INFO - PROCESS | 27119 | RSS: Main: 180428800 08:49:41 INFO - PROCESS | 27119 | 08:49:43 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36864/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:44 INFO - PROCESS | 27119 | RSS: Main: 185110528 08:49:44 INFO - PROCESS | 27119 | 08:49:47 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36864/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:48 INFO - PROCESS | 27119 | RSS: Main: 220905472 08:49:48 INFO - PROCESS | 27119 | 08:49:51 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36864/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:52 INFO - PROCESS | 27119 | RSS: Main: 214867968 08:49:52 INFO - PROCESS | 27119 | 08:49:55 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36864/tests/kraken/driver.html?testName=json-parse-financial) 08:49:55 INFO - PROCESS | 27119 | RSS: Main: 218357760 08:49:55 INFO - PROCESS | 27119 | 08:49:57 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36864/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:58 INFO - PROCESS | 27119 | RSS: Main: 181747712 08:49:58 INFO - PROCESS | 27119 | 08:49:59 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:50:00 INFO - PROCESS | 27119 | RSS: Main: 188358656 08:50:00 INFO - PROCESS | 27119 | 08:50:02 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:50:03 INFO - PROCESS | 27119 | RSS: Main: 193953792 08:50:03 INFO - PROCESS | 27119 | 08:50:06 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:50:06 INFO - PROCESS | 27119 | RSS: Main: 188690432 08:50:06 INFO - PROCESS | 27119 | 08:50:09 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:50:10 INFO - PROCESS | 27119 | RSS: Main: 191918080 08:50:10 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | Cycle 1(1): loaded http://localhost:36864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36864/tests/kraken/driver.html?testName=ai-astar) 08:50:12 INFO - PROCESS | 27119 | RSS: Main: 242987008 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | __start_tp_report 08:50:12 INFO - PROCESS | 27119 | _x_x_mozilla_page_load 08:50:12 INFO - PROCESS | 27119 | _x_x_mozilla_page_load_details 08:50:12 INFO - PROCESS | 27119 | |i|pagename|runs| 08:50:12 INFO - PROCESS | 27119 | |0;ai-astar;106;115;114;117;114;116;113;117;115;115 08:50:12 INFO - PROCESS | 27119 | |1;audio-beat-detection;153;121;127;180;122;128;152;124;183;127 08:50:12 INFO - PROCESS | 27119 | |2;audio-dft;161;159;161;162;161;162;162;162;161;160 08:50:12 INFO - PROCESS | 27119 | |3;audio-fft;76;75;76;112;76;77;76;75;105;75 08:50:12 INFO - PROCESS | 27119 | |4;audio-oscillator;86;86;131;86;86;87;115;86;87;141 08:50:12 INFO - PROCESS | 27119 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;116 08:50:12 INFO - PROCESS | 27119 | |6;imaging-darkroom;146;148;146;146;146;146;146;146;146;147 08:50:12 INFO - PROCESS | 27119 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 08:50:12 INFO - PROCESS | 27119 | |8;json-parse-financial;63;62;63;63;63;66;64;65;65;64 08:50:12 INFO - PROCESS | 27119 | |9;json-stringify-tinderbox;64;65;65;65;65;66;66;66;66;66 08:50:12 INFO - PROCESS | 27119 | |10;stanford-crypto-aes;83;83;82;90;82;92;84;82;82;83 08:50:12 INFO - PROCESS | 27119 | |11;stanford-crypto-ccm;146;132;133;134;138;128;138;131;161;134 08:50:12 INFO - PROCESS | 27119 | |12;stanford-crypto-pbkdf2;171;174;174;171;174;172;174;172;176;172 08:50:12 INFO - PROCESS | 27119 | |13;stanford-crypto-sha256-iterative;68;67;69;68;69;68;67;67;68;67 08:50:12 INFO - PROCESS | 27119 | __end_tp_report 08:50:12 INFO - PROCESS | 27119 | __start_cc_report 08:50:12 INFO - PROCESS | 27119 | _x_x_mozilla_cycle_collect,1937 08:50:12 INFO - PROCESS | 27119 | __end_cc_report 08:50:12 INFO - PROCESS | 27119 | __startTimestamp1471621812518__endTimestamp 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | ------- Summary: start ------- 08:50:12 INFO - PROCESS | 27119 | Number of tests: 14 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:3.16 (2.7%) stddev-sans-first:1.36 08:50:12 INFO - PROCESS | 27119 | Values: 106.0 115.0 114.0 117.0 114.0 116.0 113.0 117.0 115.0 115.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:140.00 stddev:23.94 (17.1%) stddev-sans-first:25.04 08:50:12 INFO - PROCESS | 27119 | Values: 153.0 121.0 127.0 180.0 122.0 128.0 152.0 124.0 183.0 127.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.99 (0.6%) stddev-sans-first:1.05 08:50:12 INFO - PROCESS | 27119 | Values: 161.0 159.0 161.0 162.0 161.0 162.0 162.0 162.0 161.0 160.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.92 (18.3%) stddev-sans-first:14.58 08:50:12 INFO - PROCESS | 27119 | Values: 76.0 75.0 76.0 112.0 76.0 77.0 76.0 75.0 105.0 75.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#4] audio-oscillator Cycles:10 Average:99.10 Median:86.00 stddev:21.54 (25.0%) stddev-sans-first:22.32 08:50:12 INFO - PROCESS | 27119 | Values: 86.0 86.0 131.0 86.0 86.0 87.0 115.0 86.0 87.0 141.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:50:12 INFO - PROCESS | 27119 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:50:12 INFO - PROCESS | 27119 | Values: 146.0 148.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:50:12 INFO - PROCESS | 27119 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 08:50:12 INFO - PROCESS | 27119 | Values: 63.0 62.0 63.0 63.0 63.0 66.0 64.0 65.0 65.0 64.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 08:50:12 INFO - PROCESS | 27119 | Values: 64.0 65.0 65.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.62 (4.4%) stddev-sans-first:3.81 08:50:12 INFO - PROCESS | 27119 | Values: 83.0 83.0 82.0 90.0 82.0 92.0 84.0 82.0 82.0 83.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:136.00 stddev:9.62 (7.1%) stddev-sans-first:9.70 08:50:12 INFO - PROCESS | 27119 | Values: 146.0 132.0 133.0 134.0 138.0 128.0 138.0 131.0 161.0 134.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.00 stddev:1.63 (0.9%) stddev-sans-first:1.56 08:50:12 INFO - PROCESS | 27119 | Values: 171.0 174.0 174.0 171.0 174.0 172.0 174.0 172.0 176.0 172.0 08:50:12 INFO - PROCESS | 27119 | 08:50:12 INFO - PROCESS | 27119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 08:50:12 INFO - PROCESS | 27119 | Values: 68.0 67.0 69.0 68.0 69.0 68.0 67.0 67.0 68.0 67.0 08:50:12 INFO - PROCESS | 27119 | -------- Summary: end -------- 08:50:12 INFO - PROCESS | 27119 | 08:50:13 INFO - TEST-INFO | 27119: exit 0 08:50:13 INFO - TEST-OK | kraken | took 64061ms 08:50:13 INFO - SUITE-END | took 1183s 08:50:14 INFO - Completed test suite (00:19:44) 08:50:14 INFO - javascript benchmark 08:50:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.780803631691, 2590.9870450647745, 2600.8959641614338, 2607.6479675243836, 2611.268844723477, 4588.220002599558, 4676.205045142326, 4690.6951048181845, 4757.119932812428, 4761.214399624062, 4707.62339012879, 4725.480197178307, 4758.571728544431, 4765.8570242892765, 4824.831130910419, 4134.37984302354, 4351.760653164082, 4404.031113155101, 4416.58042485965, 4424.889377765549, 4393.604575588196, 4412.338149277602, 4433.756143412111, 4445.51099379068, 4454.910901781963, 4154.335306350969, 4228.429162063144, 4265.317549192146, 4310.504292006397, 4340.9565904341025, 4372.27857403528, 4372.475302963665, 4373.693841431101, 4378.10248898975, 4384.956150438518, 4335.349697545394, 4336.262835318003, 4357.7821108944745, 4357.869263922087, 4368.606825385698, 4616.8153273869, 4647.326137710047, 4667.13657973276, 4676.859694209179, 4762.690425122356, 5054.671446355975, 5058.898822023539, 5063.367079115111, 5063.670861393997, 5063.696178229281, 5090.134677104901, 5096.362954630671, 5107.3360463139925, 5109.156989096832, 5112.079825631385, 4594.563516465931, 4677.7193368398, 4742.146413645542, 4743.83396581118, 4748.477667456577, 5238.869028274247, 5241.68549887008, 5250.343707036621, 5251.973740131275, 5252.133397989365, 5019.29729837823, 5027.4721154279005, 5030.622703297267, 5034.974825125851, 5036.017976494549, 4843.830465933675, 4926.901461970812, 4990.525900039491, 4991.825286114969, 5104.259882317043, 4985.202367621163, 5016.0971025215085, 5020.723860187724, 5021.974890125526, 5024.723640199751, 4968.677035992721, 4982.202847544376, 4986.276989836453, 4988.201887697951, 4990.30135780991, 4120.526139493996, 4222.683298752606, 4233.70364074518, 4254.532001479834, 4261.595148460891, 3728.5712143103347, 3737.289914916157, 3738.794366309879, 3741.1956429367274, 3756.8309426075893, 4374.1786547676575, 4380.518143004267, 4382.342648602671, 4392.736435813861, 4393.604575588212, 4934.8766280843265, 5027.396712394536, 5027.874303142377, 5093.286939828427, 5132.5124113209185, 4364.388985542027, 4388.27593447084, 4391.341298805205, 4393.297072468454, 4394.780260986938, 4609.562091601292, 4611.216093264086, 4612.723236605747, 4616.60758835496, 4624.237000894882, 4587.0, 4698.530146985274, 4743.667943244078, 4754.4532378776885, 4793.846614889008, 5069.7465126744255, 5083.517065878736, 5095.184770436712, 5100.617453690914, 5100.668456550312, 4794.760261986817, 4801.975990120027, 4802.903941921212, 4805.0149719306755, 4806.8077276909935, 4831.879203019953, 4940.901181976268, 4975.5522003019905, 4999.825006124768, 5030.195168772979, 5123.231515272739, 5126.128558145049, 5131.769070391767, 5138.306328645585, 5144.30551875492, 5006.524380183877, 5014.17266151081, 5018.749062546931, 5018.7741551631, 5025.874353141201, 4772.546608072227, 4870.853874383774, 4905.656604037683, 4935.037667654917, 4988.326575912351, 4899.534544218293, 4909.9263511048075, 4927.211646136601, 4933.33399991011, 4939.185034469272, 5018.272350509083, 5018.84943451697, 5027.195648696191, 5030.647854650139, 5030.798768049237, 4772.928406073981, 4784.449788274393, 4836.927446088241, 4846.273059041172, 4914.631402644744], "value": 4644.88696688703, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9698066606336, 566.7308028686377, 568.8975984322822, 571.45997032804, 579.5942840011993, 28286.43427131459, 38681.80659096704, 40066.399004014966, 40422.39366409503, 44238.33642495357, 40001.599984000226, 40335.79832100843, 40397.596024039754, 40466.797666011706, 40475.392869106916, 7613.847723045522, 7738.303552680258, 7762.7671169865, 7769.0677118745825, 7776.0, 7745.225477452238, 7831.490953088031, 7843.921560784376, 7863.8034049148655, 7865.370770338359, 7842.803929901741, 7854.410919181056, 7887.723929662463, 7890.250426209501, 7897.447178697494, 7812.453128281023, 7817.843643127106, 7864.921350786476, 7879.448438609328, 7885.842283154362, 7726.961365193194, 7777.688892444296, 7778.261065198797, 7786.961065194694, 7791.181925897756, 37308.0, 37533.62466375329, 37539.249215015545, 37561.0, 37720.62279377199, 2946.764258859286, 3166.224275052604, 3194.6166460024947, 3274.885379011747, 3562.0560551453887, 28721.28196795076, 28909.855450722822, 29436.705632943824, 29655.25861853449, 30653.846730766425, 3271.574695289621, 3330.58367704037, 3341.5488908997218, 3359.1937934895695, 3480.251745874624, 252189.0, 254320.0, 254328.0, 254555.72722136456, 255119.0, 44465.773831841216, 46138.538614613426, 50846.23730644043, 51067.48932510702, 51144.74427627838, 52037.73981130146, 53279.46720532823, 53535.19697204545, 58257.70871145617, 58469.0, 12451.128421010624, 12553.497860085494, 12556.121071524905, 12556.686082848002, 12563.93718031404, 9857.457839818735, 9945.353552019096, 9947.80104397908, 9954.601815927426, 9956.651517196864, 13929.303534823219, 14255.572332830032, 14271.857281427261, 14764.852351476347, 15212.619684507754, 5872.295324560994, 5965.433283838029, 6066.302375226817, 6081.8479538011015, 6145.310039739107, 785.8860465232509, 858.9012263589642, 872.3326655108847, 923.1507013547553, 977.027857282009, 27272.0, 27636.58545121825, 28115.71884281172, 28232.0, 28238.576421353697, 879.4591326334386, 893.6693423433371, 941.7975135345933, 989.188865130586, 1024.2164743970868, 13708.45166193361, 14817.259137043106, 14907.0, 14978.700425991638, 15211.619709507351, 364665.0, 367071.0, 368914.0, 369668.0, 370550.0, 49288.0, 49310.0, 49355.75322123367, 49365.50634493609, 49461.25808112881, 1126.52122847791, 1166.055495049013, 1173.8650055243756, 1175.482787573465, 1177.6290468502393, 25873.22380328593, 27033.86483067572, 27104.864475677496, 27738.44523109486, 27905.0, 42399.0, 42781.57218427776, 42841.78579107209, 42863.35704964366, 42883.356749648156, 292777.3306069829, 293060.0, 293694.0, 294902.0, 297844.0, 34559.308813824086, 35997.82001089978, 36724.0, 36724.44913326356, 36729.63270367262, 40838.68530411844, 41014.0, 41437.378439322834, 42380.15239695127, 42416.787916060224, 34561.48157777686, 34903.0, 35151.47272790859, 35268.0, 35366.115847103, 35032.82483587566, 35319.47020794639, 35611.0, 35621.0, 35758.46362304516, 34713.82643086768, 35071.47392789059, 35291.0, 35683.643163568035, 35867.10332241611, 29292.0, 32131.678683212867, 32464.350712985135, 32531.0, 32588.0, 24035.399115021566, 24206.515869682156, 24478.0, 24639.137630182857, 24935.501289973738], "value": 17182.723683953198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.28688761813527, 366.74144727966785, 371.5207382476605, 378.8257401595266, 387.96120387961207, 12504.249745015293, 16101.838981610195, 16154.757678634815, 17244.741328880045, 17398.739018914726, 14157.646058848533, 14307.570772876805, 14384.424623015093, 14493.78259326111, 14512.709745805105, 4425.291953287475, 4959.429665588449, 5146.845594632167, 5184.922226166611, 5186.7925282988635, 4983.352164218646, 5051.722155281458, 5056.570191533724, 5058.772355244023, 5060.822871199509, 4817.325574419584, 4998.625103117262, 5021.472745361739, 5031.195008798593, 5034.647574669774, 5016.774245158977, 5058.873528161807, 5061.240813877911, 5062.974685126551, 5063.696178229299, 4458.9554104459185, 4493.618042466394, 4553.726776393394, 4565.269556870885, 4567.310095264774, 20385.592288154156, 20574.897125514275, 20754.79245207544, 21084.683729744065, 21088.578228435497, 1829.4968883556994, 2043.4686981384798, 2099.8215151712125, 2349.3569734049192, 2455.1652438170927, 12939.353032348345, 13133.488900855542, 13237.139585926883, 13520.32398380077, 13906.721865562733, 1718.9312427502884, 1774.3168879981172, 1805.2508209093342, 1810.339226182434, 1811.6195598924241, 64490.355096448904, 66603.0, 67172.0, 67936.32063679399, 68493.31506684919, 8556.572171391406, 9001.864972025425, 9806.31355805101, 9863.457509836884, 10083.697489075339, 13461.528846490326, 13467.663308417172, 13482.123661961941, 13496.730065398637, 13527.188368697909, 6780.050792888999, 6871.725130994804, 6981.30186981308, 7128.465365097639, 7128.857422851514, 6367.204099487564, 6435.485161187187, 6578.80263592093, 6593.011048342787, 6605.108310378134, 6041.154238406627, 6073.331933487313, 6102.237220347457, 6120.724567394478, 6368.732948924232, 1723.2417736196035, 1758.9824101759075, 1776.644671065792, 1792.2382987230376, 1794.5154808201712, 790.2887401338841, 828.8010877389383, 929.3076657889916, 949.3449519831295, 960.9663661771805, 16682.582935426468, 16791.412300569667, 17631.382901598638, 17832.3758668446, 18194.727079093824, 809.9433039687283, 844.8141408890034, 888.6583851551209, 891.3582220801013, 905.6046756329603, 9560.56977436017, 10043.69868903934, 10216.591336346612, 10239.59041638341, 10249.282550221562, 362819.0, 366672.0, 368869.0, 379038.0, 380065.0, 48177.277340839915, 67806.0, 68081.3191868075, 68407.65796170988, 70640.64679676671, 925.2274350916925, 930.5161316115582, 945.716285114463, 970.3935040599625, 979.7991411760572, 11221.0, 15399.3070311834, 16299.674006520041, 16551.0, 16587.585310366856, 28265.858670706515, 34727.0, 34903.0, 35873.0, 36829.44755828611, 41337.93310334531, 41821.372679410444, 41914.0, 43663.781681091394, 44207.778961106276, 7273.9636301818155, 7444.776656700307, 7491.887621685788, 7536.397088233038, 7568.470207085451, 5531.778728850801, 6414.743410263537, 10918.672439826818, 11540.365279909685, 11794.997425218953, 9921.454320012468, 10151.390916545031, 10434.321769084985, 10542.103921166787, 10679.679609611723, 10003.749906252402, 10059.748506287402, 10085.0, 10323.690289291333, 10489.055984961391, 9853.359531630707, 10585.153187745116, 10598.20513461509, 10719.088877445505, 10767.246292759744, 7612.923870761443, 7634.427417943787, 7801.258880406353, 7843.0, 8036.799080023046, 9680.370775899544, 10335.17318614494, 10348.793024139626, 10432.895671043192, 10729.0], "value": 8078.2070876137395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.0920883008387, 1356.1862882270639, 1439.316324745746, 1613.749868770341, 1659.8755093368, 7169.462290328227, 7679.078510578732, 7758.534487930714, 7771.650275737584, 7784.338331241851, 6597.779410808992, 7109.075820143387, 7362.190159082496, 7396.630168491567, 7575.734849280277, 2149.258505815491, 2173.9456513587206, 2177.4882902517897, 2183.0394626364427, 2194.47332640166, 2109.3144727963395, 2144.356692992104, 2184.1263494602126, 2188.6498160294354, 2193.1008286602496, 2145.4529095080734, 2145.5387091775265, 2149.7742737012622, 2160.902759375824, 2178.1505212966954, 2151.451379898124, 2154.806067453921, 2159.4709296222527, 2160.9783902161093, 2161.686555449451, 2105.6841473778904, 2126.2876936226385, 2126.7873212678765, 2128.17001369466, 2132.637451633226, 7396.408287337, 7486.812829679302, 7521.285477879593, 7529.360004399633, 7535.058117735283, 4134.276501612206, 4255.361695745632, 4256.489221293465, 4258.190943720683, 4263.552327005651, 2697.5953606958915, 2788.2332358601343, 2808.8033837631374, 2811.4236581500745, 2814.620026296465, 851.3699862102062, 892.1078921078921, 910.4491782471641, 912.1653686876566, 913.7943962608426, 10336.121429678486, 10340.534675939602, 10377.429241391721, 10395.636152734694, 10417.843732344021, 3907.394353875097, 4079.755674519241, 4163.8334466621, 4200.684948628804, 4207.97896010518, 8793.076726943578, 8826.911730882737, 8830.381873268809, 8849.070847561043, 8861.512616806009, 4252.808623611945, 4289.206496798102, 4293.656507479394, 4298.742075475481, 4305.160493703697, 3430.8456119474686, 3782.7730336179366, 3855.383138697795, 3860.9227815443533, 3908.2769687607883, 3516.0682419158943, 3528.4707293906117, 3654.9634503654624, 3658.926821463609, 3671.1189314564313, 1140.5836869542557, 1180.1797750563276, 1180.7933611617932, 1183.1244878789635, 1183.4260383713893, 812.4353574265829, 830.0150866866197, 846.9830603387898, 849.1041950742026, 857.566928701002, 5005.295022678671, 5037.697738135724, 5153.819616313411, 5213.244079608436, 5241.9737901310245, 360.37474980908104, 374.49630247317316, 376.57070939129414, 389.5909295239987, 393.3313367275643, 3263.9673603264137, 3293.670632936687, 3309.1561651778643, 3309.4539400999047, 3451.3442445935193, 8888.155625215593, 9353.532323383804, 9353.719388418358, 9416.0, 9418.95290523543, 9269.536523173814, 9308.534573271309, 9319.021502742115, 9324.766880827898, 9325.114114159143, 7042.823929401806, 7119.893201601876, 7120.430365570845, 7134.500584959003, 7136.892946605805, 4848.200046992207, 4862.197737373293, 4898.681585696918, 4952.083864485082, 5151.433342332265, 7960.2039796019935, 8025.077116131486, 8482.363822713198, 8565.743027709179, 8595.65617375323, 8347.499150051017, 8486.660533578835, 8513.233808957224, 8517.701880434402, 8584.828303434022, 5712.714364281853, 6318.936810631835, 6546.803595892131, 6713.1944166700305, 6717.630530320879, 7095.254998225112, 7359.264073592812, 7375.8156046099275, 7380.741674041383, 7387.298206670358, 6497.252815926229, 6686.06395104676, 6697.799066028027, 6872.69072891711, 6875.724971001104, 6444.226692796894, 6597.967010164918, 6631.734730610914, 6734.124563806674, 6779.389854913082, 5860.355360910382, 5934.821955341346, 5949.613275137102, 5950.2264705587995, 5953.28560572734, 4375.0, 4381.890452738707, 4447.911041779211, 4513.119941611354, 4572.45130584332, 4314.094040251583, 4336.674749393871, 4390.736555806662, 4443.666724995703, 4489.438820147481], "value": 3916.159149648877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.60179752839844, 301.3686327144631, 302.09974276655566, 309.0758631691244, 309.5666067505492, 4852.9514704852945, 4878.609711223103, 4881.24340727187, 4885.609151267899, 4886.780094895729, 4751.501092385293, 4817.108834865552, 4820.325154478376, 4822.517748225176, 4826.444958829736, 3595.8561657533733, 3726.9813650931706, 3736.897615203508, 3741.7380783345175, 3741.9625803741887, 3631.654992775682, 3755.929560075379, 3778.8866334009886, 3807.714421418391, 3844.1735026969195, 3743.0, 3754.1177823211524, 3768.4939515222345, 3795.5139383703718, 3801.6388443097862, 3508.5263489428858, 3684.6551008881834, 3730.3844865597143, 3733.7759734415886, 3751.6623503884507, 3238.2228265216413, 3243.2054146733967, 3247.951280730791, 3255.137388592001, 3258.804471731704, 4658.417697787777, 4685.390899183084, 4689.921318096823, 4699.0, 4704.694194877322, 4200.85297014603, 4229.302165142748, 4241.639460645818, 4244.469441319835, 4257.233697934371, 4776.904461910777, 4940.0, 5010.248462730583, 5035.622328325354, 5039.823606173803, 3573.3032058748554, 3578.910527236814, 3581.803000834953, 3584.2652256287397, 3597.334493118781, 5258.605604579634, 5270.20812923604, 5278.498542638443, 5282.947170528284, 5284.837335786121, 3541.327147841902, 3638.399664055454, 3649.361361761681, 3650.1969566695284, 3657.5976642569294, 3636.381815091441, 3646.872359467459, 3647.544056992876, 3660.158163622382, 3697.3344797936093, 4181.790910454526, 4195.370694395804, 4200.172924777731, 4202.642775364067, 4204.873853784391, 4983.0033993201505, 4999.250412273235, 5009.699418034929, 5025.84922452327, 5029.748512574357, 1207.6980754811298, 1261.0857128581888, 1271.0721173543366, 1271.8807449444614, 1273.3124112979074, 801.410962942237, 811.9675212991532, 825.2407784837964, 828.0684230240979, 838.3000194837379, 4240.0, 4293.69944103916, 4357.169988604794, 4395.428594282723, 4426.911461770811, 5125.923111153335, 5138.97430512845, 5155.458676838953, 5158.277841102249, 5185.170372740419, 4414.55854414556, 4423.380726698265, 4444.755538445416, 4445.687962467982, 4452.599266066005, 2643.4845205184806, 2721.7550420462253, 2747.519184142807, 2750.80340052078, 2758.2828464599347, 4836.153673107192, 4882.926756098661, 4887.706737595756, 4888.682235654742, 4893.412790465096, 5087.465816089331, 5269.601107285779, 5287.550558202519, 5295.258663787073, 5307.177387504943, 4862.246351815475, 4874.463808981081, 4884.853454396374, 4888.364512613338, 4899.3385892904, 5152.613553983391, 5167.870803229949, 5170.44063188709, 5171.896562068813, 5184.585233181261, 4807.0, 5086.7710953007945, 5087.481696560227, 5097.617678674188, 5099.286099945936, 4909.618834865016, 4923.335349727741, 4927.630427718007, 4928.486471899286, 4947.455779864284, 3645.289168612095, 3654.3970244910356, 3663.835127419326, 3695.9651297636706, 3701.7408781385043, 5025.7916784127065, 5261.3686357637325, 5262.8947920937035, 5267.631265811357, 5283.920741188808, 5043.193089105725, 5043.4365346742625, 5049.2173713074535, 5063.164577844762, 5110.974445127899, 5023.212117274948, 5038.924416133834, 5076.0, 5085.872853178552, 5089.465606111453, 4724.6692731508465, 4997.225430058346, 4999.400071991385, 5016.473270306566, 5020.874478138076, 4836.678394370651, 4906.63200259989, 5043.84868453947, 5091.898162036812, 5109.335786347751, 4904.2835007747, 4947.950520494749, 4952.47998960104, 4952.8018879245865, 4971.130052240771], "value": 3781.6304780842124, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1357963055417, 606.557213234339, 606.8604221029163, 675.3347952267017, 677.1975209376888, 12800.679983000418, 13522.459101635935, 13596.388162532685, 13615.183089014667, 13663.521776737816, 13357.198568085922, 13434.126781759178, 13552.932235338809, 13637.659058523543, 13650.38573264203, 623.5853157650157, 746.8506298740247, 752.0636807175075, 772.4129661457276, 774.0943096577018, 761.6534476813036, 771.949823261489, 774.4501404003164, 774.5159275452842, 774.7946794099568, 831.0069466986923, 831.9500829950223, 832.4713806732738, 832.6128350317101, 832.6669332267081, 659.8416380068797, 788.2157253532772, 808.8220591469867, 830.1325115254574, 832.7626626411444, 590.5187272373003, 590.6220019187723, 592.0586267834165, 592.3188333416606, 592.6177615438019, 13435.865641343558, 13475.932620336933, 13496.5276215332, 13500.86499135006, 13518.662033449242, 12423.627291181188, 12834.743305133938, 13441.932790336083, 13649.863501364958, 13681.863181368159, 12023.939880300542, 12198.817017744741, 12222.816657750142, 12312.753744925052, 12507.562235321811, 4146.170765846812, 4153.6677065834965, 4166.375043743433, 4188.748675079474, 4262.424572682679, 62691.373086269465, 62875.0, 63793.0, 63794.36205637931, 64687.353126469076, 10646.574137034588, 10783.245172837826, 10837.783244335069, 10958.068564171976, 11364.261323014143, 19477.318293859647, 19487.0, 19494.707579386322, 19525.902370488056, 19531.609367812565, 6847.21257055435, 6874.415674667609, 6896.103506544217, 7211.639418029183, 7232.312930271616, 3670.8164591770305, 3752.3620984432714, 3783.3000894834545, 3822.4648549203134, 3907.6873850091924, 2790.525610646195, 2904.9854750726536, 2908.9709102909123, 2911.6360454943133, 2912.941741165165, 497.8929530150962, 501.93725784276967, 507.1834346701807, 512.4977522028433, 519.1045446604577, 474.632160075937, 487.39319547164007, 490.83311674030284, 500.7471227030399, 507.7393276151026, 7216.314450127229, 7347.08161479815, 7393.482456228013, 7663.808404789925, 7971.0, 464.93955785747636, 498.6783524626596, 529.9046171689133, 534.3214118070107, 558.040170906041, 3395.864165433404, 3436.0722604896537, 3437.7077948374167, 3442.1738782691973, 3447.2246792901674, 95118.0, 97001.514992426, 98703.50648246713, 100409.49795250977, 101319.49340253399, 49605.751971239915, 84055.0, 87160.56419717988, 87277.56361218153, 90365.0, 74670.62664686641, 76810.23189768143, 77420.61289693516, 77920.0, 78523.0, 6390.424861762278, 6704.882229763183, 6795.388415042472, 6972.302769722987, 7063.399611032914, 44949.0, 46473.302900457194, 46517.53482465132, 47085.29372059353, 47131.0, 59255.40744592499, 63989.68005160131, 66681.66659166673, 67577.3242267571, 69115.0, 9045.185933266037, 9205.861912071457, 9322.766930826783, 9660.806783864144, 9788.265880059167, 11074.0, 11219.158563107636, 11863.762724745284, 12093.57672481459, 12345.814812777995, 7751.37988960893, 10539.57841686324, 10952.28810127371, 11014.229003969966, 11043.447827608748, 11685.240459370114, 11706.1220408468, 11893.46479408446, 12075.57735479254, 12430.564930227398, 11252.718682033015, 11275.887241127812, 11973.461194246105, 12256.0, 12386.071044671506, 9419.952900235729, 9582.90417095848, 9710.514474276117, 9787.755306117118, 10056.994300570177, 9529.857052144362, 9695.321327507007, 9844.852327215242, 10004.799904001733, 10023.298369114093], "value": 6464.982139738364, "unit": "score"}], "name": "dromaeo_css", "value": 6286.708254331483, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 117.0, 114.0, 116.0, 113.0, 117.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 127.0, 180.0, 122.0, 128.0, 152.0, 124.0, 183.0, 127.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 112.0, 76.0, 77.0, 76.0, 75.0, 105.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 131.0, 86.0, 86.0, 87.0, 115.0, 86.0, 87.0, 141.0], "value": 99.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 66.0, 64.0, 65.0, 65.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 90.0, 82.0, 92.0, 84.0, 82.0, 82.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 132.0, 133.0, 134.0, 138.0, 128.0, 138.0, 131.0, 161.0, 134.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 174.0, 171.0, 174.0, 172.0, 174.0, 172.0, 176.0, 172.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 68.0, 69.0, 68.0, 67.0, 67.0, 68.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1548.3999999999999, "alertThreshold": 2.0}]} 08:50:14 INFO - Return code: 0 08:50:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:50:14 INFO - # TBPL SUCCESS # 08:50:14 INFO - Running post-action listener: _resource_record_post_action 08:50:14 INFO - [mozharness: 2016-08-19 15:50:14.321281Z] Finished run-tests step (success) 08:50:14 INFO - Running post-run listener: _resource_record_post_run 08:50:14 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403988480; Read time: 24; Write time: 399020 08:50:14 INFO - TinderboxPrint: CPU usage
13.0% 08:50:14 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 08:50:14 INFO - TinderboxPrint: I/O write bytes / time
403,988,480 / 399,020 08:50:14 INFO - TinderboxPrint: CPU idle
8,335.5 (87.0%) 08:50:14 INFO - TinderboxPrint: CPU user
1,198.0 (12.5%) 08:50:14 INFO - TinderboxPrint: Swap in / out
0 / 0 08:50:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 122523648; Read time: 0; Write time: 120724 08:50:14 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281464832; Read time: 8; Write time: 278296 08:50:14 INFO - Running post-run listener: _upload_blobber_files 08:50:14 INFO - Blob upload gear active. 08:50:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:50:14 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 08:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:50:15 INFO - (blobuploader) - INFO - Open directory for files ... 08:50:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:50:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:20 INFO - (blobuploader) - INFO - Done attempting. 08:50:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:50:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:50:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:21 INFO - (blobuploader) - INFO - Done attempting. 08:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:22 INFO - (blobuploader) - INFO - Done attempting. 08:50:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:50:22 INFO - Return code: 0 08:50:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:50:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:50:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad38d5106ea5bc35649265e2c093ae2d7fc5a99c2ce1ca858a140050509b3ecc53b5234397719a7f2b75c2b4a7d90f865e400c23b7fb07b8343a2cebc4fdc87d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75fe46acd63a66bd87c57f844b1b805cfd3686e3370c03a8676e03074aaf3efb01687b9a5c782cdee7eb570646189efaf0ee9379287beacfc125efa2eb53e4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bd23fd52a9a7aecaec75b12c07ef480eb4df59c810f99a4c5279c5077d7b8d422ee97604af12485183a4679bc4dd14920c8ca7bff8eb5fe01b08573ba4d63b3"} 08:50:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:50:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:50:22 INFO - Contents: 08:50:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad38d5106ea5bc35649265e2c093ae2d7fc5a99c2ce1ca858a140050509b3ecc53b5234397719a7f2b75c2b4a7d90f865e400c23b7fb07b8343a2cebc4fdc87d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75fe46acd63a66bd87c57f844b1b805cfd3686e3370c03a8676e03074aaf3efb01687b9a5c782cdee7eb570646189efaf0ee9379287beacfc125efa2eb53e4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bd23fd52a9a7aecaec75b12c07ef480eb4df59c810f99a4c5279c5077d7b8d422ee97604af12485183a4679bc4dd14920c8ca7bff8eb5fe01b08573ba4d63b3"} 08:50:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:50:22 INFO - Copying logs to upload dir... 08:50:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:50:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.143153 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-19 08:50:22.713459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:22.717494) ========= 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=41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad38d5106ea5bc35649265e2c093ae2d7fc5a99c2ce1ca858a140050509b3ecc53b5234397719a7f2b75c2b4a7d90f865e400c23b7fb07b8343a2cebc4fdc87d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75fe46acd63a66bd87c57f844b1b805cfd3686e3370c03a8676e03074aaf3efb01687b9a5c782cdee7eb570646189efaf0ee9379287beacfc125efa2eb53e4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bd23fd52a9a7aecaec75b12c07ef480eb4df59c810f99a4c5279c5077d7b8d422ee97604af12485183a4679bc4dd14920c8ca7bff8eb5fe01b08573ba4d63b3"} build_url:https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/HGl6yUyzSkuC-WdpptvTzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad38d5106ea5bc35649265e2c093ae2d7fc5a99c2ce1ca858a140050509b3ecc53b5234397719a7f2b75c2b4a7d90f865e400c23b7fb07b8343a2cebc4fdc87d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/75fe46acd63a66bd87c57f844b1b805cfd3686e3370c03a8676e03074aaf3efb01687b9a5c782cdee7eb570646189efaf0ee9379287beacfc125efa2eb53e4d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bd23fd52a9a7aecaec75b12c07ef480eb4df59c810f99a4c5279c5077d7b8d422ee97604af12485183a4679bc4dd14920c8ca7bff8eb5fe01b08573ba4d63b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:22.744145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:22.744496) ========= 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=41a7e32711b8e08598a63237000001d6-1471620572.920892-1486674119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:50:22.828431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:50:22.828812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:50:22.829198) ========= ========= Total master_lag: 0.19 =========