builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1472829933.11 results: success (0) buildid: 20160902053001 builduid: 1a1920aab797485e9a7d8161007660af revision: 884f60cd86d31b32ec4883246ace726bc93e445b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.111906) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.112432) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.112755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.184924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.185268) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 08:25: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-09-02 08:25:33 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120553 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.319869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.320192) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020611 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.369317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:33.369744) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 884f60cd86d31b32ec4883246ace726bc93e445b --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 884f60cd86d31b32ec4883246ace726bc93e445b --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=edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 08:25:33,436 truncating revision to first 12 chars 2016-09-02 08:25:33,436 Setting DEBUG logging. 2016-09-02 08:25:33,436 attempt 1/10 2016-09-02 08:25:33,436 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/884f60cd86d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 08:25:33,902 unpacking tar archive at: fx-team-884f60cd86d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.815912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:34.199304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:34.199643) ========= script_repo_revision: 884f60cd86d31b32ec4883246ace726bc93e445b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:34.200042) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:34.200324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 08:25:34.210178) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-02 08:25:34.210547) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:25:34 INFO - MultiFileLogger online at 20160902 08:25:34 in /builds/slave/test 08:25:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:25:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:25:34 INFO - {'append_to_log': False, 08:25:34 INFO - 'base_work_dir': '/builds/slave/test', 08:25:34 INFO - 'blob_upload_branch': 'Fx-Team', 08:25:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:25:34 INFO - 'branch': 'Fx-Team', 08:25:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:25:34 INFO - 'config_files': ('talos/linux_config.py',), 08:25:34 INFO - 'default_actions': ('clobber', 08:25:34 INFO - 'read-buildbot-config', 08:25:34 INFO - 'download-and-extract', 08:25:34 INFO - 'populate-webroot', 08:25:34 INFO - 'create-virtualenv', 08:25:34 INFO - 'install', 08:25:34 INFO - 'run-tests'), 08:25:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:25:34 INFO - 'download_minidump_stackwalk': True, 08:25:34 INFO - 'download_symbols': 'ondemand', 08:25:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:25:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:25:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:25:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:25:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:25:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:25:34 INFO - 'installer_path': 'installer.exe', 08:25:34 INFO - 'log_level': 'info', 08:25:34 INFO - 'log_name': 'talos', 08:25:34 INFO - 'log_to_console': True, 08:25:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:25:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:25:34 INFO - 'opt_config_files': (), 08:25:34 INFO - 'pip_index': False, 08:25:34 INFO - 'sps_profile': False, 08:25:34 INFO - 'sps_profile_interval': 0, 08:25:34 INFO - 'suite': 'dromaeojs', 08:25:34 INFO - 'system_bits': '32', 08:25:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:25:34 INFO - 'title': 'talos-linux64-ix-033', 08:25:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:25:34 INFO - 'use_talos_json': True, 08:25:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:25:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:25:34 INFO - 'work_dir': 'build'} 08:25:34 INFO - [mozharness: 2016-09-02 15:25:34.373822Z] Running clobber step. 08:25:34 INFO - Running pre-action listener: _resource_record_pre_action 08:25:34 INFO - Running main action method: clobber 08:25:34 INFO - rmtree: /builds/slave/test/build 08:25:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:25:34 INFO - Running post-action listener: _resource_record_post_action 08:25:34 INFO - [mozharness: 2016-09-02 15:25:34.845869Z] Finished clobber step (success) 08:25:34 INFO - [mozharness: 2016-09-02 15:25:34.845972Z] Running read-buildbot-config step. 08:25:34 INFO - Running pre-action listener: _resource_record_pre_action 08:25:34 INFO - Running main action method: read_buildbot_config 08:25:34 INFO - Using buildbot properties: 08:25:34 INFO - { 08:25:34 INFO - "project": "", 08:25:34 INFO - "product": "firefox", 08:25:34 INFO - "script_repo_revision": "production", 08:25:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:25:34 INFO - "repository": "", 08:25:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:25:34 INFO - "buildid": "20160902053001", 08:25:34 INFO - "pgo_build": "True", 08:25:34 INFO - "basedir": "/builds/slave/test", 08:25:34 INFO - "buildnumber": 1524, 08:25:34 INFO - "slavename": "talos-linux64-ix-033", 08:25:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:25:34 INFO - "platform": "ubuntu64_hw", 08:25:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:25:34 INFO - "branch": "fx-team", 08:25:34 INFO - "repo_path": "integration/fx-team", 08:25:34 INFO - "revision": "884f60cd86d31b32ec4883246ace726bc93e445b", 08:25:34 INFO - "stage_platform": "linux64-pgo", 08:25:34 INFO - "builduid": "1a1920aab797485e9a7d8161007660af", 08:25:34 INFO - "slavebuilddir": "test" 08:25:34 INFO - } 08:25:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:25:34 INFO - Running post-action listener: _resource_record_post_action 08:25:34 INFO - [mozharness: 2016-09-02 15:25:34.848391Z] Finished read-buildbot-config step (success) 08:25:34 INFO - [mozharness: 2016-09-02 15:25:34.848480Z] Running download-and-extract step. 08:25:34 INFO - Running pre-action listener: _resource_record_pre_action 08:25:34 INFO - Running main action method: download_and_extract 08:25:34 INFO - mkdir: /builds/slave/test/build/tests 08:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:34 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:25:34 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:35 INFO - Downloaded 1361 bytes. 08:25:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:25:35 INFO - Using the following test package requirements: 08:25:35 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:25:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:25:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:25:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'jsshell-linux-x86_64.zip'], 08:25:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:25:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:25:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:25:35 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:25:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:25:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:25:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:25: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:25:35 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:25:35 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:36 INFO - Downloaded 21905047 bytes. 08:25:36 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:25:40 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:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:40 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:25:40 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:41 INFO - Downloaded 21905047 bytes. 08:25:41 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:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:45 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:45 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:46 INFO - Downloaded 14413998 bytes. 08:25:46 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:25: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:25:47 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:47 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/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:25:48 INFO - Downloaded 59731025 bytes. 08:25:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:48 INFO - mkdir: /builds/slave/test/properties 08:25:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:48 INFO - Contents: 08:25:48 INFO - build_url:https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:48 INFO - Running post-action listener: _resource_record_post_action 08:25:48 INFO - Running post-action listener: set_extra_try_arguments 08:25:48 INFO - [mozharness: 2016-09-02 15:25:48.900673Z] Finished download-and-extract step (success) 08:25:48 INFO - [mozharness: 2016-09-02 15:25:48.900900Z] Running populate-webroot step. 08:25:48 INFO - Running pre-action listener: _resource_record_pre_action 08:25:48 INFO - Running main action method: populate_webroot 08:25:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:48 INFO - '--tppagecycles', 08:25:48 INFO - '7'], 08:25:48 INFO - 'tests': ['tsvgm']}}, 08:25:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:25:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:25:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:25:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['damp', 'tps']}, 08:25:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'tests': ['damp', 'tps']}, 08:25:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['dromaeo_dom']}, 08:25:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['basic_compositor_video']}, 08:25:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:25:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore', 08:25:48 INFO - 'tabpaint']}, 08:25:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore', 08:25:48 INFO - 'tabpaint']}, 08:25:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore', 08:25:48 INFO - 'tabpaint']}, 08:25:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore', 08:25:48 INFO - 'tabpaint']}, 08:25:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore', 08:25:48 INFO - 'tabpaint']}, 08:25:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['a11yr', 08:25:48 INFO - 'ts_paint', 08:25:48 INFO - 'tpaint', 08:25:48 INFO - 'sessionrestore', 08:25:48 INFO - 'sessionrestore_no_auto_restore', 08:25:48 INFO - 'tabpaint']}, 08:25:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['tsvgx', 08:25:48 INFO - 'tsvgr_opacity', 08:25:48 INFO - 'tart', 08:25:48 INFO - 'tscrollx', 08:25:48 INFO - 'cart']}, 08:25:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:25:48 INFO - 'tsvgr_opacity', 08:25:48 INFO - 'tart', 08:25:48 INFO - 'tscrollx', 08:25:48 INFO - 'cart']}, 08:25:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--disable-e10s'], 08:25:48 INFO - 'tests': ['tp5o']}, 08:25:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'tests': ['tp5o']}, 08:25:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--disable-e10s', 08:25:48 INFO - '--xperf_path', 08:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:48 INFO - 'tests': ['tp5n']}, 08:25:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:48 INFO - 'talos_options': ['--xperf_path', 08:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:48 INFO - 'tests': ['tp5n']}}, 08:25:48 INFO - 'talos.zip': {'path': '', 08:25:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:48 INFO - Running post-action listener: _resource_record_post_action 08:25:48 INFO - [mozharness: 2016-09-02 15:25:48.916996Z] Finished populate-webroot step (success) 08:25:48 INFO - [mozharness: 2016-09-02 15:25:48.917085Z] Running create-virtualenv step. 08:25:48 INFO - Running pre-action listener: _resource_record_pre_action 08:25:48 INFO - Running main action method: create_virtualenv 08:25:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:48 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:25:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:49 INFO - Using real prefix '/usr' 08:25:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:51 INFO - Installing pip.................done. 08:25:51 INFO - Return code: 0 08:25:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:25:51 INFO - Using env: {'DISPLAY': ':0', 08:25:51 INFO - 'HOME': '/home/cltbld', 08:25:51 INFO - 'LANG': 'en_US.UTF-8', 08:25:51 INFO - 'LANGUAGE': 'en_US:en', 08:25:51 INFO - 'LOGNAME': 'cltbld', 08:25:51 INFO - 'MAIL': '/var/mail/cltbld', 08:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:51 INFO - 'MOZ_NO_REMOTE': '1', 08:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:51 INFO - 'NO_EM_RESTART': '1', 08:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:51 INFO - 'PWD': '/builds/slave/test', 08:25:51 INFO - 'SHELL': '/bin/bash', 08:25:51 INFO - 'SHLVL': '1', 08:25:51 INFO - 'TERM': 'linux', 08:25:51 INFO - 'TMOUT': '86400', 08:25:51 INFO - 'USER': 'cltbld', 08:25:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:51 INFO - '_': '/tools/buildbot/bin/python'} 08:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:51 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:25:51 INFO - Cleaning up... 08:25:51 INFO - Return code: 0 08:25:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:25:51 INFO - Using env: {'DISPLAY': ':0', 08:25:51 INFO - 'HOME': '/home/cltbld', 08:25:51 INFO - 'LANG': 'en_US.UTF-8', 08:25:51 INFO - 'LANGUAGE': 'en_US:en', 08:25:51 INFO - 'LOGNAME': 'cltbld', 08:25:51 INFO - 'MAIL': '/var/mail/cltbld', 08:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:51 INFO - 'MOZ_NO_REMOTE': '1', 08:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:51 INFO - 'NO_EM_RESTART': '1', 08:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:51 INFO - 'PWD': '/builds/slave/test', 08:25:51 INFO - 'SHELL': '/bin/bash', 08:25:51 INFO - 'SHLVL': '1', 08:25:51 INFO - 'TERM': 'linux', 08:25:51 INFO - 'TMOUT': '86400', 08:25:51 INFO - 'USER': 'cltbld', 08:25:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:51 INFO - '_': '/tools/buildbot/bin/python'} 08:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:51 INFO - Downloading/unpacking psutil>=3.1.1 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:53 INFO - Installing collected packages: psutil 08:25:53 INFO - Running setup.py install for psutil 08:25:53 INFO - building 'psutil._psutil_linux' extension 08:25:53 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:25:54 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:25:54 INFO - building 'psutil._psutil_posix' extension 08:25:54 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:25:54 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:25:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:54 INFO - Successfully installed psutil 08:25:54 INFO - Cleaning up... 08:25:54 INFO - Return code: 0 08:25:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:25: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:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:25: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 mozsystemmonitor==0.3 08:25:54 INFO - Using env: {'DISPLAY': ':0', 08:25:54 INFO - 'HOME': '/home/cltbld', 08:25:54 INFO - 'LANG': 'en_US.UTF-8', 08:25:54 INFO - 'LANGUAGE': 'en_US:en', 08:25:54 INFO - 'LOGNAME': 'cltbld', 08:25:54 INFO - 'MAIL': '/var/mail/cltbld', 08:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:54 INFO - 'MOZ_NO_REMOTE': '1', 08:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:54 INFO - 'NO_EM_RESTART': '1', 08:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:54 INFO - 'PWD': '/builds/slave/test', 08:25:54 INFO - 'SHELL': '/bin/bash', 08:25:54 INFO - 'SHLVL': '1', 08:25:54 INFO - 'TERM': 'linux', 08:25:54 INFO - 'TMOUT': '86400', 08:25:54 INFO - 'USER': 'cltbld', 08:25:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:54 INFO - '_': '/tools/buildbot/bin/python'} 08:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:25: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:25: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:25: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:25: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:25: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:25: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:25:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:25:56 INFO - Installing collected packages: mozsystemmonitor 08:25:56 INFO - Running setup.py install for mozsystemmonitor 08:25:56 INFO - Successfully installed mozsystemmonitor 08:25:56 INFO - Cleaning up... 08:25:56 INFO - Return code: 0 08:25:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:25:56 INFO - Using env: {'DISPLAY': ':0', 08:25:56 INFO - 'HOME': '/home/cltbld', 08:25:56 INFO - 'LANG': 'en_US.UTF-8', 08:25:56 INFO - 'LANGUAGE': 'en_US:en', 08:25:56 INFO - 'LOGNAME': 'cltbld', 08:25:56 INFO - 'MAIL': '/var/mail/cltbld', 08:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:56 INFO - 'MOZ_NO_REMOTE': '1', 08:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:56 INFO - 'NO_EM_RESTART': '1', 08:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:56 INFO - 'PWD': '/builds/slave/test', 08:25:56 INFO - 'SHELL': '/bin/bash', 08:25:56 INFO - 'SHLVL': '1', 08:25:56 INFO - 'TERM': 'linux', 08:25:56 INFO - 'TMOUT': '86400', 08:25:56 INFO - 'USER': 'cltbld', 08:25:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:56 INFO - '_': '/tools/buildbot/bin/python'} 08:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:25:56 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:25:56 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:25:56 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:25:56 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:25:56 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:25:56 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:25:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:58 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:25:58 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:25:58 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:25:58 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:25:58 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:25:58 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:25:59 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:59 INFO - warning: no files found matching '*.txt' 08:25:59 INFO - no previously-included directories found matching 'build' 08:25:59 INFO - no previously-included directories found matching 'dist' 08:25:59 INFO - no previously-included directories found matching '.git*' 08:25:59 INFO - Installing collected packages: jsonschema, functools32 08:25:59 INFO - Running setup.py install for functools32 08:25:59 INFO - warning: no files found matching '*.txt' 08:25:59 INFO - no previously-included directories found matching 'build' 08:25:59 INFO - no previously-included directories found matching 'dist' 08:25:59 INFO - no previously-included directories found matching '.git*' 08:25:59 INFO - Successfully installed jsonschema functools32 08:25:59 INFO - Cleaning up... 08:25:59 INFO - Return code: 0 08:25:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:25: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:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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', '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 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:25: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:25: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 functools32==3.2.3-2 08:25:59 INFO - Using env: {'DISPLAY': ':0', 08:25:59 INFO - 'HOME': '/home/cltbld', 08:25:59 INFO - 'LANG': 'en_US.UTF-8', 08:25:59 INFO - 'LANGUAGE': 'en_US:en', 08:25:59 INFO - 'LOGNAME': 'cltbld', 08:25:59 INFO - 'MAIL': '/var/mail/cltbld', 08:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:59 INFO - 'MOZ_NO_REMOTE': '1', 08:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:59 INFO - 'NO_EM_RESTART': '1', 08:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:59 INFO - 'PWD': '/builds/slave/test', 08:25:59 INFO - 'SHELL': '/bin/bash', 08:25:59 INFO - 'SHLVL': '1', 08:25:59 INFO - 'TERM': 'linux', 08:25:59 INFO - 'TMOUT': '86400', 08:25:59 INFO - 'USER': 'cltbld', 08:25:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:59 INFO - '_': '/tools/buildbot/bin/python'} 08:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:25:59 INFO - Cleaning up... 08:25:59 INFO - Return code: 0 08:25:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25: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:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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', '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 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:25: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 blobuploader==1.2.4 08:25:59 INFO - Using env: {'DISPLAY': ':0', 08:25:59 INFO - 'HOME': '/home/cltbld', 08:25:59 INFO - 'LANG': 'en_US.UTF-8', 08:25:59 INFO - 'LANGUAGE': 'en_US:en', 08:25:59 INFO - 'LOGNAME': 'cltbld', 08:25:59 INFO - 'MAIL': '/var/mail/cltbld', 08:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:59 INFO - 'MOZ_NO_REMOTE': '1', 08:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:59 INFO - 'NO_EM_RESTART': '1', 08:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:59 INFO - 'PWD': '/builds/slave/test', 08:25:59 INFO - 'SHELL': '/bin/bash', 08:25:59 INFO - 'SHLVL': '1', 08:25:59 INFO - 'TERM': 'linux', 08:25:59 INFO - 'TMOUT': '86400', 08:25:59 INFO - 'USER': 'cltbld', 08:25:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:59 INFO - '_': '/tools/buildbot/bin/python'} 08:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:59 INFO - Downloading/unpacking blobuploader==1.2.4 08:25: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:25: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:25: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:25: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:25: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:25: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:26:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26: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:26: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:26: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:26: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:26: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:26: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:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26: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:26: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:26: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:26: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:26: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:26: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:26:02 INFO - Downloading docopt-0.6.1.tar.gz 08:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:02 INFO - Running setup.py install for blobuploader 08:26:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:02 INFO - Running setup.py install for requests 08:26:02 INFO - Running setup.py install for docopt 08:26:02 INFO - Successfully installed blobuploader requests docopt 08:26:02 INFO - Cleaning up... 08:26:02 INFO - Return code: 0 08:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26: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:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:02 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 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:26:02 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:26:02 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:26:02 INFO - Using env: {'DISPLAY': ':0', 08:26:02 INFO - 'HOME': '/home/cltbld', 08:26:02 INFO - 'LANG': 'en_US.UTF-8', 08:26:02 INFO - 'LANGUAGE': 'en_US:en', 08:26:02 INFO - 'LOGNAME': 'cltbld', 08:26:02 INFO - 'MAIL': '/var/mail/cltbld', 08:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:02 INFO - 'MOZ_NO_REMOTE': '1', 08:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:02 INFO - 'NO_EM_RESTART': '1', 08:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:02 INFO - 'PWD': '/builds/slave/test', 08:26:02 INFO - 'SHELL': '/bin/bash', 08:26:02 INFO - 'SHLVL': '1', 08:26:02 INFO - 'TERM': 'linux', 08:26:02 INFO - 'TMOUT': '86400', 08:26:02 INFO - 'USER': 'cltbld', 08:26:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:02 INFO - '_': '/tools/buildbot/bin/python'} 08:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:03 INFO - Running setup.py (path:/tmp/pip-qxFvWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:03 INFO - Running setup.py (path:/tmp/pip-VVaQ82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:03 INFO - Running setup.py (path:/tmp/pip-as09Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:03 INFO - Running setup.py (path:/tmp/pip-_aFb7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:03 INFO - Running setup.py (path:/tmp/pip-AU8A1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:03 INFO - Running setup.py (path:/tmp/pip-0mQq7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:03 INFO - Running setup.py (path:/tmp/pip-0oe9pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:03 INFO - Running setup.py (path:/tmp/pip-wPSaUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:03 INFO - Running setup.py (path:/tmp/pip-4OxC6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:03 INFO - Running setup.py (path:/tmp/pip-OmQbhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:03 INFO - Running setup.py (path:/tmp/pip-RDt30F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:03 INFO - Running setup.py (path:/tmp/pip-nmxsL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:04 INFO - Running setup.py (path:/tmp/pip-eVwFiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:04 INFO - Running setup.py (path:/tmp/pip-ossX4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:04 INFO - Running setup.py (path:/tmp/pip-34lEO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:04 INFO - Running setup.py (path:/tmp/pip-eX2iuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:04 INFO - Running setup.py (path:/tmp/pip-eX44Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:04 INFO - Running setup.py install for manifestparser 08:26:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:04 INFO - Running setup.py install for mozcrash 08:26:04 INFO - Running setup.py install for mozdebug 08:26:04 INFO - Running setup.py install for mozdevice 08:26:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:04 INFO - Running setup.py install for mozfile 08:26:04 INFO - Running setup.py install for mozhttpd 08:26:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Running setup.py install for mozinfo 08:26:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Running setup.py install for mozInstall 08:26:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Running setup.py install for mozleak 08:26:05 INFO - Running setup.py install for mozlog 08:26:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Running setup.py install for moznetwork 08:26:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Running setup.py install for mozprocess 08:26:05 INFO - Running setup.py install for mozprofile 08:26:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Running setup.py install for mozrunner 08:26:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:05 INFO - Running setup.py install for mozscreenshot 08:26:05 INFO - Running setup.py install for moztest 08:26:06 INFO - Running setup.py install for mozversion 08:26:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:06 INFO - Cleaning up... 08:26:06 INFO - Return code: 0 08:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:06 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 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:26:06 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:26:06 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:26:06 INFO - Using env: {'DISPLAY': ':0', 08:26:06 INFO - 'HOME': '/home/cltbld', 08:26:06 INFO - 'LANG': 'en_US.UTF-8', 08:26:06 INFO - 'LANGUAGE': 'en_US:en', 08:26:06 INFO - 'LOGNAME': 'cltbld', 08:26:06 INFO - 'MAIL': '/var/mail/cltbld', 08:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:06 INFO - 'MOZ_NO_REMOTE': '1', 08:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:06 INFO - 'NO_EM_RESTART': '1', 08:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:06 INFO - 'PWD': '/builds/slave/test', 08:26:06 INFO - 'SHELL': '/bin/bash', 08:26:06 INFO - 'SHLVL': '1', 08:26:06 INFO - 'TERM': 'linux', 08:26:06 INFO - 'TMOUT': '86400', 08:26:06 INFO - 'USER': 'cltbld', 08:26:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:06 INFO - '_': '/tools/buildbot/bin/python'} 08:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:06 INFO - Running setup.py (path:/tmp/pip-pe6h9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:06 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:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:06 INFO - Running setup.py (path:/tmp/pip-w1RZw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:06 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:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:06 INFO - Running setup.py (path:/tmp/pip-HbGPTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:06 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:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:06 INFO - Running setup.py (path:/tmp/pip-elVOJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:06 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:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:06 INFO - Running setup.py (path:/tmp/pip-9pZzkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:06 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:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:06 INFO - Running setup.py (path:/tmp/pip-VljhfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:06 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:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:06 INFO - Running setup.py (path:/tmp/pip-4WGztW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:06 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:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:06 INFO - Running setup.py (path:/tmp/pip-_zxvma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:07 INFO - Running setup.py (path:/tmp/pip-40Kw7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:07 INFO - Running setup.py (path:/tmp/pip-NUJTgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:07 INFO - Running setup.py (path:/tmp/pip-ypAuje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:07 INFO - Running setup.py (path:/tmp/pip-ep0UGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:07 INFO - Running setup.py (path:/tmp/pip-6QQIt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:07 INFO - Running setup.py (path:/tmp/pip-etngsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:07 INFO - Running setup.py (path:/tmp/pip-8TAD8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:07 INFO - Running setup.py (path:/tmp/pip-jP4T5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:07 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:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:07 INFO - Running setup.py (path:/tmp/pip-9F14ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:07 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:26:07 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:26:07 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:26:07 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:26:07 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:26:07 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:26:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:07 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:26:07 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:26:07 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:26:07 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:26:07 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:26:07 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:26:09 INFO - Downloading blessings-1.6.tar.gz 08:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:26:09 INFO - Installing collected packages: blessings 08:26:09 INFO - Running setup.py install for blessings 08:26:09 INFO - Successfully installed blessings 08:26:09 INFO - Cleaning up... 08:26:09 INFO - Return code: 0 08:26:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:26:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:10 INFO - Reading from file tmpfile_stdout 08:26:10 INFO - Current package versions: 08:26:10 INFO - argparse == 1.2.1 08:26:10 INFO - blessings == 1.6 08:26:10 INFO - blobuploader == 1.2.4 08:26:10 INFO - docopt == 0.6.1 08:26:10 INFO - functools32 == 3.2.3-2 08:26:10 INFO - jsonschema == 2.5.1 08:26:10 INFO - manifestparser == 1.1 08:26:10 INFO - mozInstall == 1.12 08:26:10 INFO - mozcrash == 0.17 08:26:10 INFO - mozdebug == 0.1 08:26:10 INFO - mozdevice == 0.48 08:26:10 INFO - mozfile == 1.2 08:26:10 INFO - mozhttpd == 0.7 08:26:10 INFO - mozinfo == 0.9 08:26:10 INFO - mozleak == 0.1 08:26:10 INFO - mozlog == 3.3 08:26:10 INFO - moznetwork == 0.27 08:26:10 INFO - mozprocess == 0.23 08:26:10 INFO - mozprofile == 0.28 08:26:10 INFO - mozrunner == 6.12 08:26:10 INFO - mozscreenshot == 0.1 08:26:10 INFO - mozsystemmonitor == 0.3 08:26:10 INFO - moztest == 0.7 08:26:10 INFO - mozversion == 1.4 08:26:10 INFO - psutil == 3.1.1 08:26:10 INFO - requests == 1.2.3 08:26:10 INFO - wsgiref == 0.1.2 08:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:10 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 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:26:10 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:26:10 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:26:10 INFO - Using env: {'DISPLAY': ':0', 08:26:10 INFO - 'HOME': '/home/cltbld', 08:26:10 INFO - 'LANG': 'en_US.UTF-8', 08:26:10 INFO - 'LANGUAGE': 'en_US:en', 08:26:10 INFO - 'LOGNAME': 'cltbld', 08:26:10 INFO - 'MAIL': '/var/mail/cltbld', 08:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:10 INFO - 'MOZ_NO_REMOTE': '1', 08:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:10 INFO - 'NO_EM_RESTART': '1', 08:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:10 INFO - 'PWD': '/builds/slave/test', 08:26:10 INFO - 'SHELL': '/bin/bash', 08:26:10 INFO - 'SHLVL': '1', 08:26:10 INFO - 'TERM': 'linux', 08:26:10 INFO - 'TMOUT': '86400', 08:26:10 INFO - 'USER': 'cltbld', 08:26:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:10 INFO - '_': '/tools/buildbot/bin/python'} 08:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:10 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:26:10 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:26:10 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:26:10 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:26:10 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:26:10 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:26:10 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:26:10 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:26:10 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:26:10 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:26:10 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:26:10 INFO - Cleaning up... 08:26:10 INFO - Return code: 0 08:26:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38fa51bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', '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:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:26:10 INFO - Using env: {'DISPLAY': ':0', 08:26:10 INFO - 'HOME': '/home/cltbld', 08:26:10 INFO - 'LANG': 'en_US.UTF-8', 08:26:10 INFO - 'LANGUAGE': 'en_US:en', 08:26:10 INFO - 'LOGNAME': 'cltbld', 08:26:10 INFO - 'MAIL': '/var/mail/cltbld', 08:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:10 INFO - 'MOZ_NO_REMOTE': '1', 08:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:10 INFO - 'NO_EM_RESTART': '1', 08:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:10 INFO - 'PWD': '/builds/slave/test', 08:26:10 INFO - 'SHELL': '/bin/bash', 08:26:10 INFO - 'SHLVL': '1', 08:26:10 INFO - 'TERM': 'linux', 08:26:10 INFO - 'TMOUT': '86400', 08:26:10 INFO - 'USER': 'cltbld', 08:26:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:10 INFO - '_': '/tools/buildbot/bin/python'} 08:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:26:10 INFO - Cleaning up... 08:26:10 INFO - Return code: 0 08:26:10 INFO - Running post-action listener: _resource_record_post_action 08:26:10 INFO - Running post-action listener: _start_resource_monitoring 08:26:10 INFO - Starting resource monitoring. 08:26:10 INFO - [mozharness: 2016-09-02 15:26:10.520215Z] Finished create-virtualenv step (success) 08:26:10 INFO - [mozharness: 2016-09-02 15:26:10.520719Z] Running install step. 08:26:10 INFO - Running pre-action listener: _resource_record_pre_action 08:26:10 INFO - Running main action method: install 08:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:10 INFO - Reading from file tmpfile_stdout 08:26:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:26:10 INFO - Reading from file tmpfile_stdout 08:26:10 INFO - Output received: 08:26:10 INFO - Usage: mozinstall [options] installer 08:26:10 INFO - Options: 08:26:10 INFO - -h, --help show this help message and exit 08:26:10 INFO - -d DEST, --destination=DEST 08:26:10 INFO - Directory to install application into. [default: 08:26:10 INFO - "/builds/slave/test"] 08:26:10 INFO - --app=APP Application being installed. [default: firefox] 08:26:10 INFO - mkdir: /builds/slave/test/build/application 08:26:10 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:26:10 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:26:27 INFO - Reading from file tmpfile_stdout 08:26:27 INFO - Output received: 08:26:27 INFO - /builds/slave/test/build/application/firefox/firefox 08:26:27 INFO - Running post-action listener: _resource_record_post_action 08:26:27 INFO - [mozharness: 2016-09-02 15:26:27.829763Z] Finished install step (success) 08:26:27 INFO - [mozharness: 2016-09-02 15:26:27.830046Z] Running run-tests step. 08:26:27 INFO - Running pre-action listener: _resource_record_pre_action 08:26:27 INFO - Running main action method: run_tests 08:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:26:27 INFO - Python 2.7.3 08:26:27 INFO - Return code: 0 08:26:27 INFO - grabbing minidump binary from tooltool 08:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:27 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 0x20fd370>, '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 0x21008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2100d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:26:27 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:26:27 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:26:27 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:26:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:26:27 INFO - Return code: 0 08:26:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:26:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:26:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:26:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:26:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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:26:27 INFO - Using env: {'DISPLAY': ':0', 08:26:27 INFO - 'HOME': '/home/cltbld', 08:26:27 INFO - 'LANG': 'en_US.UTF-8', 08:26:27 INFO - 'LANGUAGE': 'en_US:en', 08:26:27 INFO - 'LOGNAME': 'cltbld', 08:26:27 INFO - 'MAIL': '/var/mail/cltbld', 08:26:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:26:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:27 INFO - 'MOZ_NO_REMOTE': '1', 08:26:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:27 INFO - 'NO_EM_RESTART': '1', 08:26:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:27 INFO - 'PWD': '/builds/slave/test', 08:26:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:26:27 INFO - 'SHELL': '/bin/bash', 08:26:27 INFO - 'SHLVL': '1', 08:26:27 INFO - 'TERM': 'linux', 08:26:27 INFO - 'TMOUT': '86400', 08:26:27 INFO - 'USER': 'cltbld', 08:26:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692', 08:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:27 INFO - '_': '/tools/buildbot/bin/python'} 08:26:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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:26:28 INFO - mozversion application_buildid: 20160902053001 08:26:28 INFO - mozversion application_changeset: 884f60cd86d31b32ec4883246ace726bc93e445b 08:26:28 INFO - mozversion application_display_name: Nightly 08:26:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:26:28 INFO - mozversion application_name: Firefox 08:26:28 INFO - mozversion application_remotingname: firefox 08:26:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:26:28 INFO - mozversion application_vendor: Mozilla 08:26:28 INFO - mozversion application_version: 51.0a1 08:26:28 INFO - mozversion platform_buildid: 20160902053001 08:26:28 INFO - mozversion platform_changeset: 884f60cd86d31b32ec4883246ace726bc93e445b 08:26:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:26:28 INFO - mozversion platform_version: 51.0a1 08:26:28 INFO - using testdate: 1472829988 08:26:28 INFO - actual date: 1472829988 08:26:28 INFO - starting webserver on 'localhost:36903' 08:26:28 INFO - SUITE-START | Running 2 tests 08:26:28 INFO - TEST-START | dromaeo_css 08:26:28 INFO - operating with platform_type : linux_ 08:26:28 INFO - Initialising browser for dromaeo_css test... 08:26:28 INFO - TEST-INFO | started process 9136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpINz4O6/profile http://localhost:36903/getInfo.html) 08:26:33 INFO - PROCESS | 9136 | __metrics Screen width/height:1600/1200 08:26:33 INFO - PROCESS | 9136 | colorDepth:24 08:26:33 INFO - PROCESS | 9136 | Browser inner width/height: 1024/697 08:26:33 INFO - PROCESS | 9136 | __metrics 08:26:33 INFO - PROCESS | 9136 | 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:26:33 INFO - PROCESS | 9136 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:26:34 INFO - PROCESS | 9136 | console.error: PushService: 08:26:34 INFO - PROCESS | 9136 | stateChangeProcessEnqueue: Error transitioning state 08:26:34 INFO - PROCESS | 9136 | UnknownError 08:26:35 INFO - TEST-INFO | 9136: exit 0 08:26:35 INFO - Browser initialized. 08:26:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:26:35 INFO - TEST-INFO | started process 9218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpINz4O6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:47 INFO - PROCESS | 9218 | RSS: Main: 178556928 08:26:47 INFO - PROCESS | 9218 | 08:27:38 INFO - PROCESS | 9218 | 1472830058925 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:29:48 INFO - PROCESS | 9218 | Cycle 1(1): loaded http://localhost:36903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36903/tests/dromaeo/cssquery-ext.html) 08:29:49 INFO - PROCESS | 9218 | RSS: Main: 300158976 08:29:49 INFO - PROCESS | 9218 | 08:32:51 INFO - PROCESS | 9218 | Cycle 1(1): loaded http://localhost:36903/tests/dromaeo/cssquery-ext.html (next: http://localhost:36903/tests/dromaeo/cssquery-jquery.html) 08:32:52 INFO - PROCESS | 9218 | RSS: Main: 270364672 08:32:52 INFO - PROCESS | 9218 | 08:35:54 INFO - PROCESS | 9218 | Cycle 1(1): loaded http://localhost:36903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36903/tests/dromaeo/cssquery-mootools.html) 08:35:55 INFO - PROCESS | 9218 | RSS: Main: 215941120 08:35:55 INFO - PROCESS | 9218 | 08:38:57 INFO - PROCESS | 9218 | Cycle 1(1): loaded http://localhost:36903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36903/tests/dromaeo/cssquery-prototype.html) 08:38:57 INFO - PROCESS | 9218 | RSS: Main: 253911040 08:38:57 INFO - PROCESS | 9218 | 08:42:00 INFO - PROCESS | 9218 | Cycle 1(1): loaded http://localhost:36903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36903/tests/dromaeo/cssquery-yui.html) 08:42:01 INFO - PROCESS | 9218 | RSS: Main: 218697728 08:42:01 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | Cycle 1(1): loaded http://localhost:36903/tests/dromaeo/cssquery-yui.html (next: http://localhost:36903/tests/dromaeo/cssquery-dojo.html) 08:45:04 INFO - PROCESS | 9218 | RSS: Main: 311889920 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | __start_tp_report 08:45:04 INFO - PROCESS | 9218 | _x_x_mozilla_page_load 08:45:04 INFO - PROCESS | 9218 | _x_x_mozilla_page_load_details 08:45:04 INFO - PROCESS | 9218 | |i|pagename|runs| 08:45:04 INFO - PROCESS | 9218 | |0;dojo.html;2992.730654241118;3010.0518336723935;3032.060061380972;3061.2193890557905;3083.845807709614;5124.410692770332;5162.92255616166;5169.8190563330245;5234.084035293823;5273.736313184339;5215.713135777531;5220.817271395502;5285.048691235576;5285.603579731526;5286.074936886039;4663.3937588113495;4699.835505757299;4764.571188593026;4810;4903.926441103386;4827.710337379751;4871.585915197213;4871.8782030449165;4897.730624815634;4916.655834091615;4656.720596764171;4711.104890070876;4720.763961801897;4736.83421080264;4789.880252993686;4719.575238228542;4739.336492890998;4747.691400058985;4791.520847915215;4866.78099485524;4760.64295177863;4762.357081793948;4769.332293478916;4786.904261914777;4814.518548145193;5157.4068982067165;5186.273921650972;5312.601554883399;5314.999604023106;5400.270963419966;5614.045612245928;5616.775328986836;5617.915731264035;5633.549316054706;5720.799772007959;5617.943820561783;5679.062954612526;5681.091025435951;5684.602077854511;5687.914681279784;5108.36145481811;5216.478352164753;5262.000219958196;5285.471452854722;5292.576593872481;5766.567507436959;5771.480566749013;5774.653520788766;5795.971020144872;5844.532437404998;5567.3040869891265;5568.359638641527;5573.108302671553;5575.191597218381;5580.637258578179;5461.42655021225;5483.725813709379;5519.586031047687;5631.690257035821;5640.464155905182;5501.339839219239;5510.228568000483;5511.448855114537;5548.389677135512;5566.025945459528;5472.26124473199;5519.9448005520235;5528.170774383874;5533.3083364579425;5535.418781028015;4292.570742925683;4315.611594956469;4320.243957307459;4348.891277718082;4395.077033822933;3842.884713458601;3847.576766555677;3889.124946886984;3889.4360317753767;3909.0227443139215;5230.424653288135;5231.189165679326;5236.293100431393;5259.368875734936;5298.496642819003;5476.424975377608;5538.861528461821;5542.889142217214;5570.41510641385;5581.274434323512;5319.494648008433;5333.280007198979;5341.86645333862;5377.112776391851;5403.162509810985;4897.094037603055;4910.656254062182;4910.852674419773;4912.361393018885;4960.90078198434;5673.744681489343;5816.41835816415;5841.182234487175;5846.444587764156;5886.911696324644;5685.829425117253;5688.601797874109;5692.373838877637;5751.252337196138;5762.855928601818;5876.294844618673;5876.647401155944;5882.5293976480925;5884.440978107073;5903.321118071305;5473.31583552056;5475.5072043516275;5528.585356098389;5591.245181900392;5601.691906944994;5607.635503692247;5612.494875461228;5657.8019769307875;5684.516816070681;5718.942810571841;5432.185172224198;5437.075697131418;5444.891102178013;5450.155225939986;5454.590905682169;5355.705436201047;5430.891382172255;5432.483914028319;5478.945210547843;5536.2249285099315;5486.341639003345;5489.286392769074;5501.669899806025;5532.03189441838;5562.944370556243;5592.133219351007;5598.412166722435;5599.328080630187;5603.55171586264;5606.383297837317;5311.203319502106;5321.866953326043;5359.4104648487855;5468.507834294933;5550.58370622213 08:45:04 INFO - PROCESS | 9218 | |1;ext.html;558;598.892199404107;603.4327731931983;608.7808388979969;616.1589430427468;31654;42737.307284688744;43793.56206437939;43825.12349753003;47970.52029479704;44906.550934490646;45319.32021019687;45330.32004519927;45360.773196133974;45372.09255814882;8117.188281171865;8936.910630893706;9076.137766912167;9093;9095.408798428114;10432.530536125854;10744.73138171548;10753.731156721065;11008.669739907815;11021.779564408707;10949.343039417621;11034;11043.116550675966;11046.061084807761;11050.115990720764;10777.191710621695;10826.24216304859;10841.945790271076;10853.348799072042;10853.782924341469;10388.48057597117;10454.320469169556;10456.215783816244;10458.215633827418;10466.215033872413;41738.79130604358;41986.37020444696;42005;42009.789951050356;42077;3273;3418.8974330770116;3451.6853932584268;3661.2311414602964;3664.2671465706967;32140.517892231634;32492.512612310835;32579.348413031606;32670.183245418815;32848.6715132848;4053.574374690674;4124.731892426983;4180.770057646828;4209.894752631178;4235.280002399569;238106;238137;238299;238422;238953;56712.43287567154;56717;57349;57516.42483575111;57551;59673.40326596679;59690.70154649199;59691.70154149202;59706;59716.549603819156;15227.695446091238;15588;15606.14166220846;15939.760903586455;16094.75857862133;11700.88299116998;11722.413879306172;12017.098717596215;12721.55474558386;13012.804807927889;18572.349967751063;18666.719999200024;18733.81266187348;18748.906255468635;18800.811991879906;7056.364927156581;7079.681414336367;7118.92881071193;7261.8547629047125;7401.004322082573;915.5193523400268;977.296346630425;1053.952572134256;1092.2463500184847;1096.780643871229;31021.844890775854;31260.843695781376;32711.18222044468;32881.34237315288;34817.45147947839;1028.5063169678597;1048.5229220704562;1077.2728408324506;1102.443266150589;1144.4792619358172;15876;16351.26419311134;16368.83631163697;16460.473369823394;16492.34030638785;565708;568870.8911386076;569068;570254;570821;55256.44743552594;55839;55849.72075139598;55863.16205256924;55880.72059639676;1213.0841214882882;1332.6202032420713;1339.6583871112805;1359.9660008499866;1379.8137251471123;27691.44617107687;32208.83895580507;32464.350712985135;32520.512192316663;32583;47712.761436192595;47803.52196477991;47929.76035119802;48012.27981580209;48437.27344089912;417629;420574;422203;422252;422351;24662.63006054875;27352.589711154746;42566;43396.56603433925;43565.346519802864;44798.552014480745;49416.50583494119;49429.50570494393;49657.75171124121;49712;40482.79758601188;40602;41217.793911030254;42130.789346053076;42696.35955460733;40090.79954600208;40377.596224038556;40735.33819562417;41880.371794423714;42153.36769948392;41057.384139237336;41686.58313416827;41721.1655766889;41782.582174179086;42171;34859.128521787155;36697.81651091728;37190.25619487649;37310;37713.81143094267;27711.72288277172;27971;28030.2992425191;28183.859080704464;28228.71771282343 08:45:04 INFO - PROCESS | 9218 | |2;jquery.html;385.1622720582732;394.71383247145803;404.1916167664672;409.26536866324943;423.03969988126954;13091.541796037141;17718.734218986694;17884.91057544712;19436.708449373255;19462.12420441082;14611.707765844676;17200.39798607049;17995.82004179958;18089.366872159477;18539.16573754181;5583.916241256385;5804.100364443518;5805;5806.187133801272;5812.099124635688;5426;5672.631278966875;5703.31560212773;5748.42515748426;5751.626144300607;5560.610757246995;5595.048841696921;5606.831795046155;5615.691136987464;5647.7458514366745;5457.918131228034;5592.7762889484375;5634.859128521799;5636.408177141423;5644.8306550803545;4979.651424400294;5037.29477873098;5044.419891712427;5045.041442125985;5049.141645920203;21291.893540532354;21902.561948760937;22275.220367287227;22510.32469025932;22600;2100.789921007902;2245.9887700561394;2317.3395582258977;2609.543329917276;2647.0103854234712;13996.370163342572;14072.22602756848;14089.788653170212;14216.857831421761;14743;1803.7655104836288;1880.1445342369188;1902.5243689077731;1911.9330823421253;1925.9422217333363;83819.58090209571;86057.13942860554;86112.56943715304;86375.13624863734;87831.56084219538;10147.847782283272;10246.48767561619;10368.740781480372;10642.946785266178;10671.519781609846;15059.924700376429;15098.094114353175;15102.320395582225;15116.924415377853;15117.395304187929;7764.650590723431;7922.762317130495;7959.8408031839035;8102.513849169069;8226.506409615442;7609.467337286447;7633.770986870402;7851.646675899598;7857.096433910174;7878.369730421553;5732.713364331767;5919.55603329752;6293.496520278367;6383.425491705769;6468.773592924225;1872.2323847222847;1949.7465329507074;1988.4730546404926;2014.476236178604;2020.9895052473762;895.8387490251818;948.1371951524218;972.2805124208035;1035.171862510004;1102.1843835561626;19301.4209573713;19372.612547748966;19403.611927761365;19530.121144548528;19608.175473579264;991.9950400247952;1026.5175367577226;1030.953607087683;1040.8750949885912;1077.4181941751524;10157.339772914736;10874.510647020903;10973.640667256579;10985.6155034575;11066.723331916766;446158;460226;472619;473281;474409;49732.26472544045;55048;81375.59312203401;82471;84538.57730711307;1022.3712416863575;1032.566322144701;1033.2973577966904;1034.0331789776733;1037.1184493180735;16085;16560.337586496404;16965.91517042407;17305;17543.210555524776;27399;39299.607003929596;40003.599963999986;40592.1881562373;41537.58462415337;51623.741881290356;52190.60761050671;52957.7352113237;54298.75564310155;54482.18276725931;6424.903626445701;7335.303146201102;7339.8532029360185;8102.959485202537;8593.828123437372;9233.953830230806;12602.495900164258;12931.676708082374;12972.156809807333;13524.256165910969;11476.598319058792;11598;11697.23967942081;11741.354225517336;12094.032477401963;11414.48634811452;11471;11487.597934072268;11585.478653460783;11638.301701897914;11488.94255528717;11732.765344693229;11953.103517236068;12008.579699710468;12174.45214965311;7642.885356719765;7644.923550764644;7737.883931741141;8071.677132914852;8857.867131993155;11507.482163302504;11584.710382240512;11621.186516943733;11688.824667630162;11720.06239500855 08:45:04 INFO - PROCESS | 9218 | |3;mootools.html;1445.392934967314;1470.9190994495304;1557.7663350497423;1688.2402918686587;1723.9569010774737;7930.881036784453;8538.359623028267;8554.44396114253;9184.770380740485;9201.26389888809;8666.739997800076;8928.955355223216;8938.419002764816;8945.28437724982;8946.32902532311;2372.6678265042906;2398.6521954316613;2400.759924007603;2401.231605886117;2406.2781165650235;2034.9694754578693;2317.79139877411;2325.4070212095894;2343.7773411525877;2411.746766589509;2390.569697454466;2420.9757902421015;2421.0194871077156;2422.1401402502124;2422.2975337152207;2332.941676458085;2341.8243631727687;2365.751596082404;2368.8223383246327;2370.0282884017643;2291.106468477295;2303.8387312888103;2318.0611852199886;2337.5324935013064;2344.6834677318516;9031.864522032174;9090.77273068172;9120.817583648357;9152.542372881397;9152.771180720469;5113.53978141969;5267.26258323835;5277.12927366984;5277.551408130314;5277.815276465343;3253.8123584891346;3344.5317655528247;3398.915027124317;3403.5915690117095;3407.8807241746667;1028.2339656955542;1050.4275170032352;1072.7050061233144;1077.8437126616598;1105.950232239551;12578.68553286166;12634.178778379375;12692.17500862441;12721.363931803466;12733.490660373574;4437.667174961891;4470.284754439274;4617.746023968714;4643.72137671734;4670.766461676971;10636.574537018432;10715.142788576895;10715.410652414192;10717.196210284104;10723.731906702395;5284.9735751320995;5286.577073834084;5291.920621190685;5291.947080529222;5296.073187192303;4793.652051591979;4821.276808478686;4827.468978412372;4833.468318484964;4854.757262136879;4022.8189731462153;4052.6555242804693;4124.9587504125175;4153.480814898137;4164.063085805669;1181.2794195540714;1260.8865202131851;1300.4148133340034;1300.6423233610644;1314.5399110311505;894.2845723421237;929.2240978782658;938.9108034736689;941.75985123793;957.9089986451276;6103.816885493442;6120.846978825565;6135.417135372132;6141.7543298267565;6507.642079685568;960.5149399553181;973.9026097390346;979.3634137810337;985.2216748768536;991.3457118301886;4121.752694838319;4260.382244574519;4320.43834301545;4469.865904022885;4514.819407223675;11372.545098196146;11437.313761174357;11540.480678369493;11565.132615053904;11568.88431115695;11073.114150867912;11292.322460652387;11419.60031398897;11439.084873210124;11448.141389395829;7661.885071723928;7906.446548741533;8301.335893128535;8437.535935523483;8455.196756308142;6153.261608606996;6156.722947467285;6274.435300822765;6356.141920840627;6499.837504062436;10110.89889101129;10124.797504049731;10227.232957528364;10366.429846358522;10548.525316360936;10345.482725863527;10529.736756581147;10603.734906627396;10608.098311643596;10632.893671063499;7912.960435197787;7972.760817175494;8043.879341809995;8057.83884322322;8059.798505037186;8417.789555261168;8580.356473264404;8670.78323041929;8687.956560217159;8768.079351668239;7333.963330183315;7424.554526728413;7443.776686699408;7446.218147094477;7633.274838890296;7697.499662521918;7755.806104847424;7842.176571460142;7880;7916.920830791619;6871.587704737532;6877.690503927435;6914.723411063501;6915.757948471779;6917.342852429011;5106.259592359162;5123.28274041627;5181.430042695225;5193.11717008102;5230.97384513075;5068.847934561969;5078.695278283315;5172.508611681884;5211.765470553758;5299.49654782795 08:45:04 INFO - PROCESS | 9218 | |4;prototype.html;325.7704615562026;339.94165328933315;340.1055224758884;345.25769595369934;347.2049007772202;5187.247849061884;5222.007818514479;5271.815486457975;5353.223782551528;5361.678299302044;5185.3777546694355;5223.791048358061;5237.319148510688;5238.5023422774775;5258.50044245797;4135.338345864662;4136.834526618932;4139.2135494256145;4141.647959923403;4180.101278225181;3966.583508731585;4106.117184805266;4153.210889930919;4163.2506148893335;4216.64158546524;4037.899052523696;4056.472658554384;4062.476571285768;4067.227226826908;4103.774292413916;4046.696497762665;4051.412545180947;4063.902746258523;4069.104796944667;4069.613386728256;3592.7485076044686;3603.72972027099;3605.7115430765475;3611.476335931275;3622.166901612644;4980.576650984671;5071.3407257056715;5085.923711144335;5090.541851233407;5108.386993560759;4687.88280292992;4703.02472961357;4712.963148107411;4730.526947305277;4739.976300118512;5433.864153396157;5435.918461223085;5457.426970168154;5467.359792062405;5468.9726551367385;3842.4236364545263;3985.262726395626;4004.439378487014;4015.9397609035886;4028.979855100735;5672.8014519492035;5690.573207009491;5696.458836410535;5698.971505142447;5719.656820590736;4086.6514050363903;4101.589841015874;4113.177364527047;4144.342263094726;4154.896127596834;4051.837926482967;4099.200655872076;4126.938095928564;4160.396742472385;4200.558941311179;4685.5782979532005;4695.671303008825;4696;4697.436307643105;4708.693934894221;5530.087535556588;5543.835794483204;5567.415421380697;5569.220309156722;5570.080936645408;1341;1364.515596963064;1380.703148823008;1394.4840409048513;1406;955.7467271173144;974.5468357213788;989.1048601015948;995.7908839143861;997.6258902911409;5262.447443018505;5262.44757796451;5283.675182919503;5285.947140528622;5296.311479507639;5514.558835293167;5537.335519737658;5557.749901254453;5566.582506312043;5580.182008085891;5080.0794571424185;5220.347456567929;5241.9213711794355;5249.238860365225;5310.6813591184655;2613.9869300653377;2632.9868350658508;2639.617255497942;2671.1719366996294;2677.759001689857;5093;5100.48995100487;5124.256982737482;5145.76844042019;5180.358017411148;5076.974615126975;5079.263506791568;5357.517823395835;5796.739146738407;5849.912251316234;5919.112133180058;5922.318933322723;5937.228160339128;5940.524758019348;5969.731362088716;5563.304586926634;5707.8858422832145;5716.142578613241;5724.683322835688;5773.538116950718;5603.467670571289;5605.719714014202;5659.632123912097;5660.433956604306;5696.344920334214;5869.706514674334;5880.088971084329;5886.38192989747;5919.644821310735;5935.584509084322;3919.47087143232;4062.857799976987;4108.301588729863;4128.339465685476;4138.875833724993;5463.863403414946;5669.626572189541;5671.801486948102;5677.290338707661;5685.829425117253;5439.265699130725;5495.697736624524;5528.253685752533;5529.612927095226;5555.8611034722835;5507.228987941611;5540.501354878081;5572.275604171432;5602.887942241214;5604.523615492729;5234.947650523446;5373.758180881791;5415.377231618414;5505.752241149078;5558.194061860927;5562.471565201299;5573.916391254053;5580.358258800127;5581.330240371181;5591.664500130005;5467.589930755289;5479.561635069105;5479.7259137459105;5483.75323110469;5485.6434331768305 08:45:04 INFO - PROCESS | 9218 | |5;yui.html;679.0900193740389;686.7012849410506;698.462184118229;700.1318365227116;730.3974221267456;14519.927400362996;15241.542753717406;15242.847571524282;15291.311890964906;15294.694106117871;14068.366923488442;14198.290085495735;14216.928915355435;14217.92891035546;14228.217448040354;652.4095693397483;777.3936329662844;782.1591788827005;804.3364224514769;807.7132617920641;797.5374282915924;805.2310043908054;806.7781360125983;806.9838603227932;806.9878951815728;862.4738909265375;862.9870551941694;863.6804382378529;865.4677373415336;865.8441480533502;678.7895752316773;816.8938038055015;843.1442086282428;844.3414136973171;851.0298259983624;624.7376102037156;625.615246623328;625.7841044839523;625.8685676008043;625.9952775794875;13811.447542098304;13866.098703584235;13890.4443822247;13902.513412030632;13909.582712518539;12652.746945061139;12966.22202667843;13918.373673184731;14217.928910355486;14390;12562.371881405894;12591.433385497674;12655.240685558803;12802.231866088065;13344;4295.441592592974;4325.221460137174;4334.306510958263;4491.917031066207;4565.817367305303;67890.66054669695;69199;70504;82030;84369.57815210885;10294.691159265234;10404.219683523766;10458;10555.89444105549;10806.675799726021;21656.675149872764;22409.21567745154;23205.419864503187;23207.88396058009;23310.65034024491;8145.755627331189;8363;8369.246767790928;8460.238578527962;8601.440906341068;4400.141972315368;4488.316881169561;4521.434820647419;4527.524609915911;4668.416447944007;3409.3010932758725;3486.459598762196;3511.9297614047578;3524.0661224775454;3527.171114788023;566.7053132371144;572.6735760616409;586.8620874094585;588.0019831432821;588.2705445247861;645.1999520594429;664.5248647217167;685.3283781893772;685.6297599296324;696.7456878239406;8787.384883058252;8911.50986695725;8947.150020748019;8968.327375446868;9389.061743069384;541.4774742373628;599.2315502379037;645.4352441613588;657.0341597851246;660.131926516629;3753.5871054184017;3773.1699026214187;3843.7693738375788;3954.9011274717786;4032.838686452568;70325.64837175781;89296.553517232;104771;130262;135578.3221083908;108167;111274.44362778134;111555.44222278836;113992;114455.42772286086;91180.54409727908;92886;92926.53536732274;94376.52811735898;99304;7415.666295016629;7483.625818709152;7569.394448444222;7668.463207575416;7820.296173344426;53311;53617.7319113402;54138.187927180334;54403;55940;74132.25867741254;74196.62901685457;82095.589522052;82818.58590707008;85910.14089859021;11269.605563805228;11507.482163302839;11600.709982250512;11819.586314478953;12138.02895768354;12449.439775210318;12596.622101336974;12684.23894566329;12910.461151982594;13023.739525209632;11906.583269585522;12408.255504669749;12533;12592.874071259537;12604.117711760455;11836.82244766312;11941.701457463285;12456;12547;12554.497820087094;11467.655970320904;11730.413479326171;12091.15361924692;12419.689507762378;12433.93783031079;9464.668736594185;9481.857772133286;9528.796333697193;9801.411915285105;10296.845547316947;9023.954880225558;10004.899951000396;10043.196544276587;10059.195264378686;10067 08:45:04 INFO - PROCESS | 9218 | __end_tp_report 08:45:04 INFO - PROCESS | 9218 | __start_cc_report 08:45:04 INFO - PROCESS | 9218 | _x_x_mozilla_cycle_collect,953 08:45:04 INFO - PROCESS | 9218 | __end_cc_report 08:45:04 INFO - PROCESS | 9218 | __startTimestamp1472831104745__endTimestamp 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | ------- Summary: start ------- 08:45:04 INFO - PROCESS | 9218 | Number of tests: 6 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | [#0] dojo.html Cycles:165 Average:5226.37 Median:5437.08 stddev:590.25 (10.9%) stddev-sans-first:565.46 08:45:04 INFO - PROCESS | 9218 | Values: 2992.7 3010.1 3032.1 3061.2 3083.8 5124.4 5162.9 5169.8 5234.1 5273.7 5215.7 5220.8 5285.0 5285.6 5286.1 4663.4 4699.8 4764.6 4810.0 4903.9 4827.7 4871.6 4871.9 4897.7 4916.7 4656.7 4711.1 4720.8 4736.8 4789.9 4719.6 4739.3 4747.7 4791.5 4866.8 4760.6 4762.4 4769.3 4786.9 4814.5 5157.4 5186.3 5312.6 5315.0 5400.3 5614.0 5616.8 5617.9 5633.5 5720.8 5617.9 5679.1 5681.1 5684.6 5687.9 5108.4 5216.5 5262.0 5285.5 5292.6 5766.6 5771.5 5774.7 5796.0 5844.5 5567.3 5568.4 5573.1 5575.2 5580.6 5461.4 5483.7 5519.6 5631.7 5640.5 5501.3 5510.2 5511.4 5548.4 5566.0 5472.3 5519.9 5528.2 5533.3 5535.4 4292.6 4315.6 4320.2 4348.9 4395.1 3842.9 3847.6 3889.1 3889.4 3909.0 5230.4 5231.2 5236.3 5259.4 5298.5 5476.4 5538.9 5542.9 5570.4 5581.3 5319.5 5333.3 5341.9 5377.1 5403.2 4897.1 4910.7 4910.9 4912.4 4960.9 5673.7 5816.4 5841.2 5846.4 5886.9 5685.8 5688.6 5692.4 5751.3 5762.9 5876.3 5876.6 5882.5 5884.4 5903.3 5473.3 5475.5 5528.6 5591.2 5601.7 5607.6 5612.5 5657.8 5684.5 5718.9 5432.2 5437.1 5444.9 5450.2 5454.6 5355.7 5430.9 5432.5 5478.9 5536.2 5486.3 5489.3 5501.7 5532.0 5562.9 5592.1 5598.4 5599.3 5603.6 5606.4 5311.2 5321.9 5359.4 5468.5 5550.6 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | [#1] ext.html Cycles:180 Average:57842.20 Median:38902.31 stddev:114696.67 (294.8%) stddev-sans-first:114937.78 08:45:04 INFO - PROCESS | 9218 | Values: 558.0 598.9 603.4 608.8 616.2 31654.0 42737.3 43793.6 43825.1 47970.5 44906.6 45319.3 45330.3 45360.8 45372.1 8117.2 8936.9 9076.1 9093.0 9095.4 10432.5 10744.7 10753.7 11008.7 11021.8 10949.3 11034.0 11043.1 11046.1 11050.1 10777.2 10826.2 10841.9 10853.3 10853.8 10388.5 10454.3 10456.2 10458.2 10466.2 41738.8 41986.4 42005.0 42009.8 42077.0 3273.0 3418.9 3451.7 3661.2 3664.3 32140.5 32492.5 32579.3 32670.2 32848.7 4053.6 4124.7 4180.8 4209.9 4235.3 238106.0 238137.0 238299.0 238422.0 238953.0 56712.4 56717.0 57349.0 57516.4 57551.0 59673.4 59690.7 59691.7 59706.0 59716.5 15227.7 15588.0 15606.1 15939.8 16094.8 11700.9 11722.4 12017.1 12721.6 13012.8 18572.3 18666.7 18733.8 18748.9 18800.8 7056.4 7079.7 7118.9 7261.9 7401.0 915.5 977.3 1054.0 1092.2 1096.8 31021.8 31260.8 32711.2 32881.3 34817.5 1028.5 1048.5 1077.3 1102.4 1144.5 15876.0 16351.3 16368.8 16460.5 16492.3 565708.0 568870.9 569068.0 570254.0 570821.0 55256.4 55839.0 55849.7 55863.2 55880.7 1213.1 1332.6 1339.7 1360.0 1379.8 27691.4 32208.8 32464.4 32520.5 32583.0 47712.8 47803.5 47929.8 48012.3 48437.3 417629.0 420574.0 422203.0 422252.0 422351.0 24662.6 27352.6 42566.0 43396.6 43565.3 44798.6 49416.5 49429.5 49657.8 49712.0 40482.8 40602.0 41217.8 42130.8 42696.4 40090.8 40377.6 40735.3 41880.4 42153.4 41057.4 41686.6 41721.2 41782.6 42171.0 34859.1 36697.8 37190.3 37310.0 37713.8 27711.7 27971.0 28030.3 28183.9 28228.7 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | [#2] jquery.html Cycles:180 Average:27514.05 Median:22555.16 stddev:76566.54 (339.5%) stddev-sans-first:76754.23 08:45:04 INFO - PROCESS | 9218 | Values: 385.2 394.7 404.2 409.3 423.0 13091.5 17718.7 17884.9 19436.7 19462.1 14611.7 17200.4 17995.8 18089.4 18539.2 5583.9 5804.1 5805.0 5806.2 5812.1 5426.0 5672.6 5703.3 5748.4 5751.6 5560.6 5595.0 5606.8 5615.7 5647.7 5457.9 5592.8 5634.9 5636.4 5644.8 4979.7 5037.3 5044.4 5045.0 5049.1 21291.9 21902.6 22275.2 22510.3 22600.0 2100.8 2246.0 2317.3 2609.5 2647.0 13996.4 14072.2 14089.8 14216.9 14743.0 1803.8 1880.1 1902.5 1911.9 1925.9 83819.6 86057.1 86112.6 86375.1 87831.6 10147.8 10246.5 10368.7 10642.9 10671.5 15059.9 15098.1 15102.3 15116.9 15117.4 7764.7 7922.8 7959.8 8102.5 8226.5 7609.5 7633.8 7851.6 7857.1 7878.4 5732.7 5919.6 6293.5 6383.4 6468.8 1872.2 1949.7 1988.5 2014.5 2021.0 895.8 948.1 972.3 1035.2 1102.2 19301.4 19372.6 19403.6 19530.1 19608.2 992.0 1026.5 1031.0 1040.9 1077.4 10157.3 10874.5 10973.6 10985.6 11066.7 446158.0 460226.0 472619.0 473281.0 474409.0 49732.3 55048.0 81375.6 82471.0 84538.6 1022.4 1032.6 1033.3 1034.0 1037.1 16085.0 16560.3 16965.9 17305.0 17543.2 27399.0 39299.6 40003.6 40592.2 41537.6 51623.7 52190.6 52957.7 54298.8 54482.2 6424.9 7335.3 7339.9 8103.0 8593.8 9234.0 12602.5 12931.7 12972.2 13524.3 11476.6 11598.0 11697.2 11741.4 12094.0 11414.5 11471.0 11487.6 11585.5 11638.3 11488.9 11732.8 11953.1 12008.6 12174.5 7642.9 7644.9 7737.9 8071.7 8857.9 11507.5 11584.7 11621.2 11688.8 11720.1 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | [#3] mootools.html Cycles:180 Average:5911.53 Median:4807.46 stddev:3402.43 (70.8%) stddev-sans-first:3395.42 08:45:04 INFO - PROCESS | 9218 | Values: 1445.4 1470.9 1557.8 1688.2 1724.0 7930.9 8538.4 8554.4 9184.8 9201.3 8666.7 8929.0 8938.4 8945.3 8946.3 2372.7 2398.7 2400.8 2401.2 2406.3 2035.0 2317.8 2325.4 2343.8 2411.7 2390.6 2421.0 2421.0 2422.1 2422.3 2332.9 2341.8 2365.8 2368.8 2370.0 2291.1 2303.8 2318.1 2337.5 2344.7 9031.9 9090.8 9120.8 9152.5 9152.8 5113.5 5267.3 5277.1 5277.6 5277.8 3253.8 3344.5 3398.9 3403.6 3407.9 1028.2 1050.4 1072.7 1077.8 1106.0 12578.7 12634.2 12692.2 12721.4 12733.5 4437.7 4470.3 4617.7 4643.7 4670.8 10636.6 10715.1 10715.4 10717.2 10723.7 5285.0 5286.6 5291.9 5291.9 5296.1 4793.7 4821.3 4827.5 4833.5 4854.8 4022.8 4052.7 4125.0 4153.5 4164.1 1181.3 1260.9 1300.4 1300.6 1314.5 894.3 929.2 938.9 941.8 957.9 6103.8 6120.8 6135.4 6141.8 6507.6 960.5 973.9 979.4 985.2 991.3 4121.8 4260.4 4320.4 4469.9 4514.8 11372.5 11437.3 11540.5 11565.1 11568.9 11073.1 11292.3 11419.6 11439.1 11448.1 7661.9 7906.4 8301.3 8437.5 8455.2 6153.3 6156.7 6274.4 6356.1 6499.8 10110.9 10124.8 10227.2 10366.4 10548.5 10345.5 10529.7 10603.7 10608.1 10632.9 7913.0 7972.8 8043.9 8057.8 8059.8 8417.8 8580.4 8670.8 8688.0 8768.1 7334.0 7424.6 7443.8 7446.2 7633.3 7697.5 7755.8 7842.2 7880.0 7916.9 6871.6 6877.7 6914.7 6915.8 6917.3 5106.3 5123.3 5181.4 5193.1 5231.0 5068.8 5078.7 5172.5 5211.8 5299.5 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | [#4] prototype.html Cycles:180 Average:4619.62 Median:5240.21 stddev:1361.72 (26.0%) stddev-sans-first:1326.86 08:45:04 INFO - PROCESS | 9218 | Values: 325.8 339.9 340.1 345.3 347.2 5187.2 5222.0 5271.8 5353.2 5361.7 5185.4 5223.8 5237.3 5238.5 5258.5 4135.3 4136.8 4139.2 4141.6 4180.1 3966.6 4106.1 4153.2 4163.3 4216.6 4037.9 4056.5 4062.5 4067.2 4103.8 4046.7 4051.4 4063.9 4069.1 4069.6 3592.7 3603.7 3605.7 3611.5 3622.2 4980.6 5071.3 5085.9 5090.5 5108.4 4687.9 4703.0 4713.0 4730.5 4740.0 5433.9 5435.9 5457.4 5467.4 5469.0 3842.4 3985.3 4004.4 4015.9 4029.0 5672.8 5690.6 5696.5 5699.0 5719.7 4086.7 4101.6 4113.2 4144.3 4154.9 4051.8 4099.2 4126.9 4160.4 4200.6 4685.6 4695.7 4696.0 4697.4 4708.7 5530.1 5543.8 5567.4 5569.2 5570.1 1341.0 1364.5 1380.7 1394.5 1406.0 955.7 974.5 989.1 995.8 997.6 5262.4 5262.4 5283.7 5285.9 5296.3 5514.6 5537.3 5557.7 5566.6 5580.2 5080.1 5220.3 5241.9 5249.2 5310.7 2614.0 2633.0 2639.6 2671.2 2677.8 5093.0 5100.5 5124.3 5145.8 5180.4 5077.0 5079.3 5357.5 5796.7 5849.9 5919.1 5922.3 5937.2 5940.5 5969.7 5563.3 5707.9 5716.1 5724.7 5773.5 5603.5 5605.7 5659.6 5660.4 5696.3 5869.7 5880.1 5886.4 5919.6 5935.6 3919.5 4062.9 4108.3 4128.3 4138.9 5463.9 5669.6 5671.8 5677.3 5685.8 5439.3 5495.7 5528.3 5529.6 5555.9 5507.2 5540.5 5572.3 5602.9 5604.5 5234.9 5373.8 5415.4 5505.8 5558.2 5562.5 5573.9 5580.4 5581.3 5591.7 5467.6 5479.6 5479.7 5483.8 5485.6 08:45:04 INFO - PROCESS | 9218 | 08:45:04 INFO - PROCESS | 9218 | [#5] yui.html Cycles:180 Average:20894.77 Median:4546.67 stddev:31415.77 (691.0%) stddev-sans-first:31467.23 08:45:04 INFO - PROCESS | 9218 | Values: 679.1 686.7 698.5 700.1 730.4 14519.9 15241.5 15242.8 15291.3 15294.7 14068.4 14198.3 14216.9 14217.9 14228.2 652.4 777.4 782.2 804.3 807.7 797.5 805.2 806.8 807.0 807.0 862.5 863.0 863.7 865.5 865.8 678.8 816.9 843.1 844.3 851.0 624.7 625.6 625.8 625.9 626.0 13811.4 13866.1 13890.4 13902.5 13909.6 12652.7 12966.2 13918.4 14217.9 14390.0 12562.4 12591.4 12655.2 12802.2 13344.0 4295.4 4325.2 4334.3 4491.9 4565.8 67890.7 69199.0 70504.0 82030.0 84369.6 10294.7 10404.2 10458.0 10555.9 10806.7 21656.7 22409.2 23205.4 23207.9 23310.7 8145.8 8363.0 8369.2 8460.2 8601.4 4400.1 4488.3 4521.4 4527.5 4668.4 3409.3 3486.5 3511.9 3524.1 3527.2 566.7 572.7 586.9 588.0 588.3 645.2 664.5 685.3 685.6 696.7 8787.4 8911.5 8947.2 8968.3 9389.1 541.5 599.2 645.4 657.0 660.1 3753.6 3773.2 3843.8 3954.9 4032.8 70325.6 89296.6 104771.0 130262.0 135578.3 108167.0 111274.4 111555.4 113992.0 114455.4 91180.5 92886.0 92926.5 94376.5 99304.0 7415.7 7483.6 7569.4 7668.5 7820.3 53311.0 53617.7 54138.2 54403.0 55940.0 74132.3 74196.6 82095.6 82818.6 85910.1 11269.6 11507.5 11600.7 11819.6 12138.0 12449.4 12596.6 12684.2 12910.5 13023.7 11906.6 12408.3 12533.0 12592.9 12604.1 11836.8 11941.7 12456.0 12547.0 12554.5 11467.7 11730.4 12091.2 12419.7 12433.9 9464.7 9481.9 9528.8 9801.4 10296.8 9024.0 10004.9 10043.2 10059.2 10067.0 08:45:04 INFO - PROCESS | 9218 | -------- Summary: end -------- 08:45:04 INFO - PROCESS | 9218 | 08:45:05 INFO - TEST-INFO | 9218: exit 0 08:45:05 INFO - TEST-OK | dromaeo_css | took 1117662ms 08:45:05 INFO - TEST-START | kraken 08:45:05 INFO - operating with platform_type : linux_ 08:45:05 INFO - Initialising browser for kraken test... 08:45:05 INFO - TEST-INFO | started process 9527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk8Bc1Q/profile http://localhost:36903/getInfo.html) 08:45:10 INFO - PROCESS | 9527 | __metrics Screen width/height:1600/1200 08:45:10 INFO - PROCESS | 9527 | colorDepth:24 08:45:10 INFO - PROCESS | 9527 | Browser inner width/height: 1024/697 08:45:10 INFO - PROCESS | 9527 | __metrics 08:45:11 INFO - PROCESS | 9527 | 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:45:11 INFO - PROCESS | 9527 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:11 INFO - PROCESS | 9527 | console.error: PushService: 08:45:11 INFO - PROCESS | 9527 | stateChangeProcessEnqueue: Error transitioning state 08:45:11 INFO - PROCESS | 9527 | UnknownError 08:45:12 INFO - TEST-INFO | 9527: exit 0 08:45:12 INFO - Browser initialized. 08:45:12 INFO - Running cycle 1/1 for kraken test... 08:45:12 INFO - TEST-INFO | started process 9608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk8Bc1Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:24 INFO - PROCESS | 9608 | RSS: Main: 178900992 08:45:24 INFO - PROCESS | 9608 | 08:45:27 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36903/tests/kraken/driver.html?testName=audio-beat-detection) 08:45:28 INFO - PROCESS | 9608 | RSS: Main: 237846528 08:45:28 INFO - PROCESS | 9608 | 08:45:30 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36903/tests/kraken/driver.html?testName=audio-dft) 08:45:31 INFO - PROCESS | 9608 | RSS: Main: 223997952 08:45:31 INFO - PROCESS | 9608 | 08:45:34 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36903/tests/kraken/driver.html?testName=audio-fft) 08:45:34 INFO - PROCESS | 9608 | RSS: Main: 300949504 08:45:34 INFO - PROCESS | 9608 | 08:45:37 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36903/tests/kraken/driver.html?testName=audio-oscillator) 08:45:37 INFO - PROCESS | 9608 | RSS: Main: 211664896 08:45:37 INFO - PROCESS | 9608 | 08:45:39 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:45:40 INFO - PROCESS | 9608 | RSS: Main: 213016576 08:45:40 INFO - PROCESS | 9608 | 08:45:43 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36903/tests/kraken/driver.html?testName=imaging-darkroom) 08:45:43 INFO - PROCESS | 9608 | RSS: Main: 252092416 08:45:43 INFO - PROCESS | 9608 | 08:45:47 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36903/tests/kraken/driver.html?testName=imaging-desaturate) 08:45:47 INFO - PROCESS | 9608 | RSS: Main: 250781696 08:45:47 INFO - PROCESS | 9608 | 08:45:50 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36903/tests/kraken/driver.html?testName=json-parse-financial) 08:45:51 INFO - PROCESS | 9608 | RSS: Main: 251150336 08:45:51 INFO - PROCESS | 9608 | 08:45:52 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:53 INFO - PROCESS | 9608 | RSS: Main: 213475328 08:45:53 INFO - PROCESS | 9608 | 08:45:55 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:55 INFO - PROCESS | 9608 | RSS: Main: 221995008 08:45:55 INFO - PROCESS | 9608 | 08:45:57 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:58 INFO - PROCESS | 9608 | RSS: Main: 221331456 08:45:58 INFO - PROCESS | 9608 | 08:46:01 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:46:01 INFO - PROCESS | 9608 | RSS: Main: 215920640 08:46:01 INFO - PROCESS | 9608 | 08:46:04 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:46:05 INFO - PROCESS | 9608 | RSS: Main: 219709440 08:46:05 INFO - PROCESS | 9608 | 08:46:06 INFO - PROCESS | 9608 | Cycle 1(1): loaded http://localhost:36903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36903/tests/kraken/driver.html?testName=ai-astar) 08:46:07 INFO - PROCESS | 9608 | RSS: Main: 270925824 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | __start_tp_report 08:46:07 INFO - PROCESS | 9608 | _x_x_mozilla_page_load 08:46:07 INFO - PROCESS | 9608 | _x_x_mozilla_page_load_details 08:46:07 INFO - PROCESS | 9608 | |i|pagename|runs| 08:46:07 INFO - PROCESS | 9608 | |0;ai-astar;112;111;116;112;110;111;111;110;110;127 08:46:07 INFO - PROCESS | 9608 | |1;audio-beat-detection;144;124;147;185;117;145;151;120;181;116 08:46:07 INFO - PROCESS | 9608 | |2;audio-dft;159;161;162;159;161;160;159;162;160;161 08:46:07 INFO - PROCESS | 9608 | |3;audio-fft;74;75;75;183;77;75;74;74;163;77 08:46:07 INFO - PROCESS | 9608 | |4;audio-oscillator;81;81;146;82;81;81;142;81;81;143 08:46:07 INFO - PROCESS | 9608 | |5;imaging-gaussian-blur;116;117;116;117;118;117;117;117;117;116 08:46:07 INFO - PROCESS | 9608 | |6;imaging-darkroom;145;146;145;146;145;146;146;146;146;145 08:46:07 INFO - PROCESS | 9608 | |7;imaging-desaturate;96;96;96;96;95;95;95;95;95;96 08:46:07 INFO - PROCESS | 9608 | |8;json-parse-financial;55;54;53;55;57;54;54;55;54;56 08:46:07 INFO - PROCESS | 9608 | |9;json-stringify-tinderbox;60;61;61;61;61;61;60;61;61;61 08:46:07 INFO - PROCESS | 9608 | |10;stanford-crypto-aes;82;79;83;85;80;79;87;82;80;79 08:46:07 INFO - PROCESS | 9608 | |11;stanford-crypto-ccm;136;136;124;127;124;123;131;131;214;138 08:46:07 INFO - PROCESS | 9608 | |12;stanford-crypto-pbkdf2;173;162;169;168;166;168;167;166;165;163 08:46:07 INFO - PROCESS | 9608 | |13;stanford-crypto-sha256-iterative;68;70;66;67;66;64;64;64;66;64 08:46:07 INFO - PROCESS | 9608 | __end_tp_report 08:46:07 INFO - PROCESS | 9608 | __start_cc_report 08:46:07 INFO - PROCESS | 9608 | _x_x_mozilla_cycle_collect,1676 08:46:07 INFO - PROCESS | 9608 | __end_cc_report 08:46:07 INFO - PROCESS | 9608 | __startTimestamp1472831167159__endTimestamp 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | ------- Summary: start ------- 08:46:07 INFO - PROCESS | 9608 | Number of tests: 14 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#0] ai-astar Cycles:10 Average:113.00 Median:111.50 stddev:5.23 (4.7%) stddev-sans-first:5.53 08:46:07 INFO - PROCESS | 9608 | Values: 112.0 111.0 116.0 112.0 110.0 111.0 111.0 110.0 110.0 127.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:146.00 stddev:24.92 (17.1%) stddev-sans-first:26.43 08:46:07 INFO - PROCESS | 9608 | Values: 144.0 124.0 147.0 185.0 117.0 145.0 151.0 120.0 181.0 116.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 08:46:07 INFO - PROCESS | 9608 | Values: 159.0 161.0 162.0 159.0 161.0 160.0 159.0 162.0 160.0 161.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:41.55 (55.4%) stddev-sans-first:43.39 08:46:07 INFO - PROCESS | 9608 | Values: 74.0 75.0 75.0 183.0 77.0 75.0 74.0 74.0 163.0 77.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:81.00 stddev:30.22 (37.3%) stddev-sans-first:31.27 08:46:07 INFO - PROCESS | 9608 | Values: 81.0 81.0 146.0 82.0 81.0 81.0 142.0 81.0 81.0 143.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 08:46:07 INFO - PROCESS | 9608 | Values: 116.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:46:07 INFO - PROCESS | 9608 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:46:07 INFO - PROCESS | 9608 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.16 (2.1%) stddev-sans-first:1.22 08:46:07 INFO - PROCESS | 9608 | Values: 55.0 54.0 53.0 55.0 57.0 54.0 54.0 55.0 54.0 56.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 08:46:07 INFO - PROCESS | 9608 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:2.76 (3.4%) stddev-sans-first:2.92 08:46:07 INFO - PROCESS | 9608 | Values: 82.0 79.0 83.0 85.0 80.0 79.0 87.0 82.0 80.0 79.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:133.50 stddev:27.12 (20.3%) stddev-sans-first:28.75 08:46:07 INFO - PROCESS | 9608 | Values: 136.0 136.0 124.0 127.0 124.0 123.0 131.0 131.0 214.0 138.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.50 stddev:3.13 (1.9%) stddev-sans-first:2.35 08:46:07 INFO - PROCESS | 9608 | Values: 173.0 162.0 169.0 168.0 166.0 168.0 167.0 166.0 165.0 163.0 08:46:07 INFO - PROCESS | 9608 | 08:46:07 INFO - PROCESS | 9608 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:2.02 (3.1%) stddev-sans-first:2.00 08:46:07 INFO - PROCESS | 9608 | Values: 68.0 70.0 66.0 67.0 66.0 64.0 64.0 64.0 66.0 64.0 08:46:07 INFO - PROCESS | 9608 | -------- Summary: end -------- 08:46:07 INFO - PROCESS | 9608 | 08:46:08 INFO - TEST-INFO | 9608: exit 0 08:46:08 INFO - TEST-OK | kraken | took 62587ms 08:46:08 INFO - SUITE-END | took 1180s 08:46:08 INFO - Completed test suite (00:19:40) 08:46:08 INFO - javascript benchmark 08:46:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2992.730654241118, 3010.0518336723935, 3032.060061380972, 3061.2193890557905, 3083.845807709614, 5124.410692770332, 5162.92255616166, 5169.8190563330245, 5234.084035293823, 5273.736313184339, 5215.713135777531, 5220.817271395502, 5285.048691235576, 5285.603579731526, 5286.074936886039, 4663.3937588113495, 4699.835505757299, 4764.571188593026, 4810.0, 4903.926441103386, 4827.710337379751, 4871.585915197213, 4871.8782030449165, 4897.730624815634, 4916.655834091615, 4656.720596764171, 4711.104890070876, 4720.763961801897, 4736.83421080264, 4789.880252993686, 4719.575238228542, 4739.336492890998, 4747.691400058985, 4791.520847915215, 4866.78099485524, 4760.64295177863, 4762.357081793948, 4769.332293478916, 4786.904261914777, 4814.518548145193, 5157.4068982067165, 5186.273921650972, 5312.601554883399, 5314.999604023106, 5400.270963419966, 5614.045612245928, 5616.775328986836, 5617.915731264035, 5633.549316054706, 5720.799772007959, 5617.943820561783, 5679.062954612526, 5681.091025435951, 5684.602077854511, 5687.914681279784, 5108.36145481811, 5216.478352164753, 5262.000219958196, 5285.471452854722, 5292.576593872481, 5766.567507436959, 5771.480566749013, 5774.653520788766, 5795.971020144872, 5844.532437404998, 5567.3040869891265, 5568.359638641527, 5573.108302671553, 5575.191597218381, 5580.637258578179, 5461.42655021225, 5483.725813709379, 5519.586031047687, 5631.690257035821, 5640.464155905182, 5501.339839219239, 5510.228568000483, 5511.448855114537, 5548.389677135512, 5566.025945459528, 5472.26124473199, 5519.9448005520235, 5528.170774383874, 5533.3083364579425, 5535.418781028015, 4292.570742925683, 4315.611594956469, 4320.243957307459, 4348.891277718082, 4395.077033822933, 3842.884713458601, 3847.576766555677, 3889.124946886984, 3889.4360317753767, 3909.0227443139215, 5230.424653288135, 5231.189165679326, 5236.293100431393, 5259.368875734936, 5298.496642819003, 5476.424975377608, 5538.861528461821, 5542.889142217214, 5570.41510641385, 5581.274434323512, 5319.494648008433, 5333.280007198979, 5341.86645333862, 5377.112776391851, 5403.162509810985, 4897.094037603055, 4910.656254062182, 4910.852674419773, 4912.361393018885, 4960.90078198434, 5673.744681489343, 5816.41835816415, 5841.182234487175, 5846.444587764156, 5886.911696324644, 5685.829425117253, 5688.601797874109, 5692.373838877637, 5751.252337196138, 5762.855928601818, 5876.294844618673, 5876.647401155944, 5882.5293976480925, 5884.440978107073, 5903.321118071305, 5473.31583552056, 5475.5072043516275, 5528.585356098389, 5591.245181900392, 5601.691906944994, 5607.635503692247, 5612.494875461228, 5657.8019769307875, 5684.516816070681, 5718.942810571841, 5432.185172224198, 5437.075697131418, 5444.891102178013, 5450.155225939986, 5454.590905682169, 5355.705436201047, 5430.891382172255, 5432.483914028319, 5478.945210547843, 5536.2249285099315, 5486.341639003345, 5489.286392769074, 5501.669899806025, 5532.03189441838, 5562.944370556243, 5592.133219351007, 5598.412166722435, 5599.328080630187, 5603.55171586264, 5606.383297837317, 5311.203319502106, 5321.866953326043, 5359.4104648487855, 5468.507834294933, 5550.58370622213], "value": 5186.693270042109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.0, 598.892199404107, 603.4327731931983, 608.7808388979969, 616.1589430427468, 31654.0, 42737.307284688744, 43793.56206437939, 43825.12349753003, 47970.52029479704, 44906.550934490646, 45319.32021019687, 45330.32004519927, 45360.773196133974, 45372.09255814882, 8117.188281171865, 8936.910630893706, 9076.137766912167, 9093.0, 9095.408798428114, 10432.530536125854, 10744.73138171548, 10753.731156721065, 11008.669739907815, 11021.779564408707, 10949.343039417621, 11034.0, 11043.116550675966, 11046.061084807761, 11050.115990720764, 10777.191710621695, 10826.24216304859, 10841.945790271076, 10853.348799072042, 10853.782924341469, 10388.48057597117, 10454.320469169556, 10456.215783816244, 10458.215633827418, 10466.215033872413, 41738.79130604358, 41986.37020444696, 42005.0, 42009.789951050356, 42077.0, 3273.0, 3418.8974330770116, 3451.6853932584268, 3661.2311414602964, 3664.2671465706967, 32140.517892231634, 32492.512612310835, 32579.348413031606, 32670.183245418815, 32848.6715132848, 4053.574374690674, 4124.731892426983, 4180.770057646828, 4209.894752631178, 4235.280002399569, 238106.0, 238137.0, 238299.0, 238422.0, 238953.0, 56712.43287567154, 56717.0, 57349.0, 57516.42483575111, 57551.0, 59673.40326596679, 59690.70154649199, 59691.70154149202, 59706.0, 59716.549603819156, 15227.695446091238, 15588.0, 15606.14166220846, 15939.760903586455, 16094.75857862133, 11700.88299116998, 11722.413879306172, 12017.098717596215, 12721.55474558386, 13012.804807927889, 18572.349967751063, 18666.719999200024, 18733.81266187348, 18748.906255468635, 18800.811991879906, 7056.364927156581, 7079.681414336367, 7118.92881071193, 7261.8547629047125, 7401.004322082573, 915.5193523400268, 977.296346630425, 1053.952572134256, 1092.2463500184847, 1096.780643871229, 31021.844890775854, 31260.843695781376, 32711.18222044468, 32881.34237315288, 34817.45147947839, 1028.5063169678597, 1048.5229220704562, 1077.2728408324506, 1102.443266150589, 1144.4792619358172, 15876.0, 16351.26419311134, 16368.83631163697, 16460.473369823394, 16492.34030638785, 565708.0, 568870.8911386076, 569068.0, 570254.0, 570821.0, 55256.44743552594, 55839.0, 55849.72075139598, 55863.16205256924, 55880.72059639676, 1213.0841214882882, 1332.6202032420713, 1339.6583871112805, 1359.9660008499866, 1379.8137251471123, 27691.44617107687, 32208.83895580507, 32464.350712985135, 32520.512192316663, 32583.0, 47712.761436192595, 47803.52196477991, 47929.76035119802, 48012.27981580209, 48437.27344089912, 417629.0, 420574.0, 422203.0, 422252.0, 422351.0, 24662.63006054875, 27352.589711154746, 42566.0, 43396.56603433925, 43565.346519802864, 44798.552014480745, 49416.50583494119, 49429.50570494393, 49657.75171124121, 49712.0, 40482.79758601188, 40602.0, 41217.793911030254, 42130.789346053076, 42696.35955460733, 40090.79954600208, 40377.596224038556, 40735.33819562417, 41880.371794423714, 42153.36769948392, 41057.384139237336, 41686.58313416827, 41721.1655766889, 41782.582174179086, 42171.0, 34859.128521787155, 36697.81651091728, 37190.25619487649, 37310.0, 37713.81143094267, 27711.72288277172, 27971.0, 28030.2992425191, 28183.859080704464, 28228.71771282343], "value": 20287.59363711762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1622720582732, 394.71383247145803, 404.1916167664672, 409.26536866324943, 423.03969988126954, 13091.541796037141, 17718.734218986694, 17884.91057544712, 19436.708449373255, 19462.12420441082, 14611.707765844676, 17200.39798607049, 17995.82004179958, 18089.366872159477, 18539.16573754181, 5583.916241256385, 5804.100364443518, 5805.0, 5806.187133801272, 5812.099124635688, 5426.0, 5672.631278966875, 5703.31560212773, 5748.42515748426, 5751.626144300607, 5560.610757246995, 5595.048841696921, 5606.831795046155, 5615.691136987464, 5647.7458514366745, 5457.918131228034, 5592.7762889484375, 5634.859128521799, 5636.408177141423, 5644.8306550803545, 4979.651424400294, 5037.29477873098, 5044.419891712427, 5045.041442125985, 5049.141645920203, 21291.893540532354, 21902.561948760937, 22275.220367287227, 22510.32469025932, 22600.0, 2100.789921007902, 2245.9887700561394, 2317.3395582258977, 2609.543329917276, 2647.0103854234712, 13996.370163342572, 14072.22602756848, 14089.788653170212, 14216.857831421761, 14743.0, 1803.7655104836288, 1880.1445342369188, 1902.5243689077731, 1911.9330823421253, 1925.9422217333363, 83819.58090209571, 86057.13942860554, 86112.56943715304, 86375.13624863734, 87831.56084219538, 10147.847782283272, 10246.48767561619, 10368.740781480372, 10642.946785266178, 10671.519781609846, 15059.924700376429, 15098.094114353175, 15102.320395582225, 15116.924415377853, 15117.395304187929, 7764.650590723431, 7922.762317130495, 7959.8408031839035, 8102.513849169069, 8226.506409615442, 7609.467337286447, 7633.770986870402, 7851.646675899598, 7857.096433910174, 7878.369730421553, 5732.713364331767, 5919.55603329752, 6293.496520278367, 6383.425491705769, 6468.773592924225, 1872.2323847222847, 1949.7465329507074, 1988.4730546404926, 2014.476236178604, 2020.9895052473762, 895.8387490251818, 948.1371951524218, 972.2805124208035, 1035.171862510004, 1102.1843835561626, 19301.4209573713, 19372.612547748966, 19403.611927761365, 19530.121144548528, 19608.175473579264, 991.9950400247952, 1026.5175367577226, 1030.953607087683, 1040.8750949885912, 1077.4181941751524, 10157.339772914736, 10874.510647020903, 10973.640667256579, 10985.6155034575, 11066.723331916766, 446158.0, 460226.0, 472619.0, 473281.0, 474409.0, 49732.26472544045, 55048.0, 81375.59312203401, 82471.0, 84538.57730711307, 1022.3712416863575, 1032.566322144701, 1033.2973577966904, 1034.0331789776733, 1037.1184493180735, 16085.0, 16560.337586496404, 16965.91517042407, 17305.0, 17543.210555524776, 27399.0, 39299.607003929596, 40003.599963999986, 40592.1881562373, 41537.58462415337, 51623.741881290356, 52190.60761050671, 52957.7352113237, 54298.75564310155, 54482.18276725931, 6424.903626445701, 7335.303146201102, 7339.8532029360185, 8102.959485202537, 8593.828123437372, 9233.953830230806, 12602.495900164258, 12931.676708082374, 12972.156809807333, 13524.256165910969, 11476.598319058792, 11598.0, 11697.23967942081, 11741.354225517336, 12094.032477401963, 11414.48634811452, 11471.0, 11487.597934072268, 11585.478653460783, 11638.301701897914, 11488.94255528717, 11732.765344693229, 11953.103517236068, 12008.579699710468, 12174.45214965311, 7642.885356719765, 7644.923550764644, 7737.883931741141, 8071.677132914852, 8857.867131993155, 11507.482163302504, 11584.710382240512, 11621.186516943733, 11688.824667630162, 11720.06239500855], "value": 9080.573369224261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.392934967314, 1470.9190994495304, 1557.7663350497423, 1688.2402918686587, 1723.9569010774737, 7930.881036784453, 8538.359623028267, 8554.44396114253, 9184.770380740485, 9201.26389888809, 8666.739997800076, 8928.955355223216, 8938.419002764816, 8945.28437724982, 8946.32902532311, 2372.6678265042906, 2398.6521954316613, 2400.759924007603, 2401.231605886117, 2406.2781165650235, 2034.9694754578693, 2317.79139877411, 2325.4070212095894, 2343.7773411525877, 2411.746766589509, 2390.569697454466, 2420.9757902421015, 2421.0194871077156, 2422.1401402502124, 2422.2975337152207, 2332.941676458085, 2341.8243631727687, 2365.751596082404, 2368.8223383246327, 2370.0282884017643, 2291.106468477295, 2303.8387312888103, 2318.0611852199886, 2337.5324935013064, 2344.6834677318516, 9031.864522032174, 9090.77273068172, 9120.817583648357, 9152.542372881397, 9152.771180720469, 5113.53978141969, 5267.26258323835, 5277.12927366984, 5277.551408130314, 5277.815276465343, 3253.8123584891346, 3344.5317655528247, 3398.915027124317, 3403.5915690117095, 3407.8807241746667, 1028.2339656955542, 1050.4275170032352, 1072.7050061233144, 1077.8437126616598, 1105.950232239551, 12578.68553286166, 12634.178778379375, 12692.17500862441, 12721.363931803466, 12733.490660373574, 4437.667174961891, 4470.284754439274, 4617.746023968714, 4643.72137671734, 4670.766461676971, 10636.574537018432, 10715.142788576895, 10715.410652414192, 10717.196210284104, 10723.731906702395, 5284.9735751320995, 5286.577073834084, 5291.920621190685, 5291.947080529222, 5296.073187192303, 4793.652051591979, 4821.276808478686, 4827.468978412372, 4833.468318484964, 4854.757262136879, 4022.8189731462153, 4052.6555242804693, 4124.9587504125175, 4153.480814898137, 4164.063085805669, 1181.2794195540714, 1260.8865202131851, 1300.4148133340034, 1300.6423233610644, 1314.5399110311505, 894.2845723421237, 929.2240978782658, 938.9108034736689, 941.75985123793, 957.9089986451276, 6103.816885493442, 6120.846978825565, 6135.417135372132, 6141.7543298267565, 6507.642079685568, 960.5149399553181, 973.9026097390346, 979.3634137810337, 985.2216748768536, 991.3457118301886, 4121.752694838319, 4260.382244574519, 4320.43834301545, 4469.865904022885, 4514.819407223675, 11372.545098196146, 11437.313761174357, 11540.480678369493, 11565.132615053904, 11568.88431115695, 11073.114150867912, 11292.322460652387, 11419.60031398897, 11439.084873210124, 11448.141389395829, 7661.885071723928, 7906.446548741533, 8301.335893128535, 8437.535935523483, 8455.196756308142, 6153.261608606996, 6156.722947467285, 6274.435300822765, 6356.141920840627, 6499.837504062436, 10110.89889101129, 10124.797504049731, 10227.232957528364, 10366.429846358522, 10548.525316360936, 10345.482725863527, 10529.736756581147, 10603.734906627396, 10608.098311643596, 10632.893671063499, 7912.960435197787, 7972.760817175494, 8043.879341809995, 8057.83884322322, 8059.798505037186, 8417.789555261168, 8580.356473264404, 8670.78323041929, 8687.956560217159, 8768.079351668239, 7333.963330183315, 7424.554526728413, 7443.776686699408, 7446.218147094477, 7633.274838890296, 7697.499662521918, 7755.806104847424, 7842.176571460142, 7880.0, 7916.920830791619, 6871.587704737532, 6877.690503927435, 6914.723411063501, 6915.757948471779, 6917.342852429011, 5106.259592359162, 5123.28274041627, 5181.430042695225, 5193.11717008102, 5230.97384513075, 5068.847934561969, 5078.695278283315, 5172.508611681884, 5211.765470553758, 5299.49654782795], "value": 4706.022000863657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.7704615562026, 339.94165328933315, 340.1055224758884, 345.25769595369934, 347.2049007772202, 5187.247849061884, 5222.007818514479, 5271.815486457975, 5353.223782551528, 5361.678299302044, 5185.3777546694355, 5223.791048358061, 5237.319148510688, 5238.5023422774775, 5258.50044245797, 4135.338345864662, 4136.834526618932, 4139.2135494256145, 4141.647959923403, 4180.101278225181, 3966.583508731585, 4106.117184805266, 4153.210889930919, 4163.2506148893335, 4216.64158546524, 4037.899052523696, 4056.472658554384, 4062.476571285768, 4067.227226826908, 4103.774292413916, 4046.696497762665, 4051.412545180947, 4063.902746258523, 4069.104796944667, 4069.613386728256, 3592.7485076044686, 3603.72972027099, 3605.7115430765475, 3611.476335931275, 3622.166901612644, 4980.576650984671, 5071.3407257056715, 5085.923711144335, 5090.541851233407, 5108.386993560759, 4687.88280292992, 4703.02472961357, 4712.963148107411, 4730.526947305277, 4739.976300118512, 5433.864153396157, 5435.918461223085, 5457.426970168154, 5467.359792062405, 5468.9726551367385, 3842.4236364545263, 3985.262726395626, 4004.439378487014, 4015.9397609035886, 4028.979855100735, 5672.8014519492035, 5690.573207009491, 5696.458836410535, 5698.971505142447, 5719.656820590736, 4086.6514050363903, 4101.589841015874, 4113.177364527047, 4144.342263094726, 4154.896127596834, 4051.837926482967, 4099.200655872076, 4126.938095928564, 4160.396742472385, 4200.558941311179, 4685.5782979532005, 4695.671303008825, 4696.0, 4697.436307643105, 4708.693934894221, 5530.087535556588, 5543.835794483204, 5567.415421380697, 5569.220309156722, 5570.080936645408, 1341.0, 1364.515596963064, 1380.703148823008, 1394.4840409048513, 1406.0, 955.7467271173144, 974.5468357213788, 989.1048601015948, 995.7908839143861, 997.6258902911409, 5262.447443018505, 5262.44757796451, 5283.675182919503, 5285.947140528622, 5296.311479507639, 5514.558835293167, 5537.335519737658, 5557.749901254453, 5566.582506312043, 5580.182008085891, 5080.0794571424185, 5220.347456567929, 5241.9213711794355, 5249.238860365225, 5310.6813591184655, 2613.9869300653377, 2632.9868350658508, 2639.617255497942, 2671.1719366996294, 2677.759001689857, 5093.0, 5100.48995100487, 5124.256982737482, 5145.76844042019, 5180.358017411148, 5076.974615126975, 5079.263506791568, 5357.517823395835, 5796.739146738407, 5849.912251316234, 5919.112133180058, 5922.318933322723, 5937.228160339128, 5940.524758019348, 5969.731362088716, 5563.304586926634, 5707.8858422832145, 5716.142578613241, 5724.683322835688, 5773.538116950718, 5603.467670571289, 5605.719714014202, 5659.632123912097, 5660.433956604306, 5696.344920334214, 5869.706514674334, 5880.088971084329, 5886.38192989747, 5919.644821310735, 5935.584509084322, 3919.47087143232, 4062.857799976987, 4108.301588729863, 4128.339465685476, 4138.875833724993, 5463.863403414946, 5669.626572189541, 5671.801486948102, 5677.290338707661, 5685.829425117253, 5439.265699130725, 5495.697736624524, 5528.253685752533, 5529.612927095226, 5555.8611034722835, 5507.228987941611, 5540.501354878081, 5572.275604171432, 5602.887942241214, 5604.523615492729, 5234.947650523446, 5373.758180881791, 5415.377231618414, 5505.752241149078, 5558.194061860927, 5562.471565201299, 5573.916391254053, 5580.358258800127, 5581.330240371181, 5591.664500130005, 5467.589930755289, 5479.561635069105, 5479.7259137459105, 5483.75323110469, 5485.6434331768305], "value": 4189.923759122823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.0900193740389, 686.7012849410506, 698.462184118229, 700.1318365227116, 730.3974221267456, 14519.927400362996, 15241.542753717406, 15242.847571524282, 15291.311890964906, 15294.694106117871, 14068.366923488442, 14198.290085495735, 14216.928915355435, 14217.92891035546, 14228.217448040354, 652.4095693397483, 777.3936329662844, 782.1591788827005, 804.3364224514769, 807.7132617920641, 797.5374282915924, 805.2310043908054, 806.7781360125983, 806.9838603227932, 806.9878951815728, 862.4738909265375, 862.9870551941694, 863.6804382378529, 865.4677373415336, 865.8441480533502, 678.7895752316773, 816.8938038055015, 843.1442086282428, 844.3414136973171, 851.0298259983624, 624.7376102037156, 625.615246623328, 625.7841044839523, 625.8685676008043, 625.9952775794875, 13811.447542098304, 13866.098703584235, 13890.4443822247, 13902.513412030632, 13909.582712518539, 12652.746945061139, 12966.22202667843, 13918.373673184731, 14217.928910355486, 14390.0, 12562.371881405894, 12591.433385497674, 12655.240685558803, 12802.231866088065, 13344.0, 4295.441592592974, 4325.221460137174, 4334.306510958263, 4491.917031066207, 4565.817367305303, 67890.66054669695, 69199.0, 70504.0, 82030.0, 84369.57815210885, 10294.691159265234, 10404.219683523766, 10458.0, 10555.89444105549, 10806.675799726021, 21656.675149872764, 22409.21567745154, 23205.419864503187, 23207.88396058009, 23310.65034024491, 8145.755627331189, 8363.0, 8369.246767790928, 8460.238578527962, 8601.440906341068, 4400.141972315368, 4488.316881169561, 4521.434820647419, 4527.524609915911, 4668.416447944007, 3409.3010932758725, 3486.459598762196, 3511.9297614047578, 3524.0661224775454, 3527.171114788023, 566.7053132371144, 572.6735760616409, 586.8620874094585, 588.0019831432821, 588.2705445247861, 645.1999520594429, 664.5248647217167, 685.3283781893772, 685.6297599296324, 696.7456878239406, 8787.384883058252, 8911.50986695725, 8947.150020748019, 8968.327375446868, 9389.061743069384, 541.4774742373628, 599.2315502379037, 645.4352441613588, 657.0341597851246, 660.131926516629, 3753.5871054184017, 3773.1699026214187, 3843.7693738375788, 3954.9011274717786, 4032.838686452568, 70325.64837175781, 89296.553517232, 104771.0, 130262.0, 135578.3221083908, 108167.0, 111274.44362778134, 111555.44222278836, 113992.0, 114455.42772286086, 91180.54409727908, 92886.0, 92926.53536732274, 94376.52811735898, 99304.0, 7415.666295016629, 7483.625818709152, 7569.394448444222, 7668.463207575416, 7820.296173344426, 53311.0, 53617.7319113402, 54138.187927180334, 54403.0, 55940.0, 74132.25867741254, 74196.62901685457, 82095.589522052, 82818.58590707008, 85910.14089859021, 11269.605563805228, 11507.482163302839, 11600.709982250512, 11819.586314478953, 12138.02895768354, 12449.439775210318, 12596.622101336974, 12684.23894566329, 12910.461151982594, 13023.739525209632, 11906.583269585522, 12408.255504669749, 12533.0, 12592.874071259537, 12604.117711760455, 11836.82244766312, 11941.701457463285, 12456.0, 12547.0, 12554.497820087094, 11467.655970320904, 11730.413479326171, 12091.15361924692, 12419.689507762378, 12433.93783031079, 9464.668736594185, 9481.857772133286, 9528.796333697193, 9801.411915285105, 10296.845547316947, 9023.954880225558, 10004.899951000396, 10043.196544276587, 10059.195264378686, 10067.0], "value": 7225.582915630197, "unit": "score"}], "name": "dromaeo_css", "value": 7172.471623173691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 116.0, 112.0, 110.0, 111.0, 111.0, 110.0, 110.0, 127.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 147.0, 185.0, 117.0, 145.0, 151.0, 120.0, 181.0, 116.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 162.0, 159.0, 161.0, 160.0, 159.0, 162.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 183.0, 77.0, 75.0, 74.0, 74.0, 163.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 146.0, 82.0, 81.0, 81.0, 142.0, 81.0, 81.0, 143.0], "value": 99.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 118.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": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 57.0, 54.0, 54.0, 55.0, 54.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 83.0, 85.0, 80.0, 79.0, 87.0, 82.0, 80.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 124.0, 127.0, 124.0, 123.0, 131.0, 131.0, 214.0, 138.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 162.0, 169.0, 168.0, 166.0, 168.0, 167.0, 166.0, 165.0, 163.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 66.0, 67.0, 66.0, 64.0, 64.0, 64.0, 66.0, 64.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1537.0000000000002, "alertThreshold": 2.0}]} 08:46:08 INFO - Return code: 0 08:46:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:46:08 INFO - # TBPL SUCCESS # 08:46:08 INFO - Running post-action listener: _resource_record_post_action 08:46:08 INFO - [mozharness: 2016-09-02 15:46:08.977572Z] Finished run-tests step (success) 08:46:08 INFO - Running post-run listener: _resource_record_post_run 08:46:09 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 418070528; Read time: 0; Write time: 748568 08:46:09 INFO - TinderboxPrint: CPU usage
13.1% 08:46:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:46:09 INFO - TinderboxPrint: I/O write bytes / time
418,070,528 / 748,568 08:46:09 INFO - TinderboxPrint: CPU idle
8,307.8 (86.9%) 08:46:09 INFO - TinderboxPrint: CPU user
1,196.5 (12.5%) 08:46:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:46:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128880640; Read time: 0; Write time: 204820 08:46:09 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288776192; Read time: 0; Write time: 543712 08:46:09 INFO - Running post-run listener: _upload_blobber_files 08:46:09 INFO - Blob upload gear active. 08:46:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:46:09 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:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:46:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:13 INFO - (blobuploader) - INFO - Done attempting. 08:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:46:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:14 INFO - (blobuploader) - INFO - Done attempting. 08:46:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:46:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:46:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:16 INFO - (blobuploader) - INFO - Done attempting. 08:46:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:46:16 INFO - Return code: 0 08:46:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:46:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:46:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d74c8d35f9212447dcac88fc3d98f2c3bd1b9c2e533ef4101e1393cfad3e836f3d93803ee9349d1f09d15632ebd98963b20d4d63e7aea9a5e17769d6d96593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efb250a3557781bb8af1cbd3873572b776ad64ae5bc449ebff1011d319893eadf06d9dc63687f03f65e56fc75f570ce083e76e7cab2d0eba2e0d2023fd24272f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/652722202eea155c8b2a44ce313b12ba19e7436ed3eb128767c9a9feb045ee0aee5a1522f03d9b3890b121b126f592975fae738962b58a0e8c2abe2368562fcd"} 08:46:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:46:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:46:16 INFO - Contents: 08:46:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d74c8d35f9212447dcac88fc3d98f2c3bd1b9c2e533ef4101e1393cfad3e836f3d93803ee9349d1f09d15632ebd98963b20d4d63e7aea9a5e17769d6d96593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efb250a3557781bb8af1cbd3873572b776ad64ae5bc449ebff1011d319893eadf06d9dc63687f03f65e56fc75f570ce083e76e7cab2d0eba2e0d2023fd24272f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/652722202eea155c8b2a44ce313b12ba19e7436ed3eb128767c9a9feb045ee0aee5a1522f03d9b3890b121b126f592975fae738962b58a0e8c2abe2368562fcd"} 08:46:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:46:16 INFO - Copying logs to upload dir... 08:46:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:46:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.149338 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-02 08:46:16.388127) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 08:46:16.392141) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d74c8d35f9212447dcac88fc3d98f2c3bd1b9c2e533ef4101e1393cfad3e836f3d93803ee9349d1f09d15632ebd98963b20d4d63e7aea9a5e17769d6d96593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efb250a3557781bb8af1cbd3873572b776ad64ae5bc449ebff1011d319893eadf06d9dc63687f03f65e56fc75f570ce083e76e7cab2d0eba2e0d2023fd24272f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/652722202eea155c8b2a44ce313b12ba19e7436ed3eb128767c9a9feb045ee0aee5a1522f03d9b3890b121b126f592975fae738962b58a0e8c2abe2368562fcd"} build_url:https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d74c8d35f9212447dcac88fc3d98f2c3bd1b9c2e533ef4101e1393cfad3e836f3d93803ee9349d1f09d15632ebd98963b20d4d63e7aea9a5e17769d6d96593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efb250a3557781bb8af1cbd3873572b776ad64ae5bc449ebff1011d319893eadf06d9dc63687f03f65e56fc75f570ce083e76e7cab2d0eba2e0d2023fd24272f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/652722202eea155c8b2a44ce313b12ba19e7436ed3eb128767c9a9feb045ee0aee5a1522f03d9b3890b121b126f592975fae738962b58a0e8c2abe2368562fcd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 08:46:16.421547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:46:16.421903) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1472829508.406804-170121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:46:16.502619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 08:46:16.502963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 08:46:16.503292) ========= ========= Total master_lag: 0.18 =========