builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1468897454.53 results: success (0) buildid: 20160718173017 builduid: cb019b03bb964ffdadab5a67dc7e6346 revision: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.527858) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.528762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.529554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.553702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.554035) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 20:04:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-07-18 20:04:15 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.659210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.659529) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.709250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:14.709595) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 --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 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 --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=d6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 20:04:15,678 truncating revision to first 12 chars 2016-07-18 20:04:15,678 Setting DEBUG logging. 2016-07-18 20:04:15,678 attempt 1/10 2016-07-18 20:04:15,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62bb8900cfef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 20:04:15,977 unpacking tar archive at: fx-team-62bb8900cfef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645170 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:15.369297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:15.369590) ========= script_repo_revision: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:15.369997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:15.370287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:04:15.381724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-18 20:04:15.382239) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:04:16 INFO - MultiFileLogger online at 20160718 20:04:16 in /builds/slave/test 20:04:16 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 20:04:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:04:16 INFO - {'append_to_log': False, 20:04:16 INFO - 'base_work_dir': '/builds/slave/test', 20:04:16 INFO - 'blob_upload_branch': 'Fx-Team', 20:04:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:04:16 INFO - 'branch': 'Fx-Team', 20:04:16 INFO - 'buildbot_json_path': 'buildprops.json', 20:04:16 INFO - 'config_files': ('talos/linux_config.py',), 20:04:16 INFO - 'default_actions': ('clobber', 20:04:16 INFO - 'read-buildbot-config', 20:04:16 INFO - 'download-and-extract', 20:04:16 INFO - 'populate-webroot', 20:04:16 INFO - 'create-virtualenv', 20:04:16 INFO - 'install', 20:04:16 INFO - 'run-tests'), 20:04:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:04:16 INFO - 'download_minidump_stackwalk': True, 20:04:16 INFO - 'download_symbols': 'ondemand', 20:04:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:04:16 INFO - 'tooltool.py': '/tools/tooltool.py', 20:04:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:04:16 INFO - '/tools/misc-python/virtualenv.py')}, 20:04:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:04:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:04:16 INFO - 'installer_path': 'installer.exe', 20:04:16 INFO - 'log_level': 'info', 20:04:16 INFO - 'log_name': 'talos', 20:04:16 INFO - 'log_to_console': True, 20:04:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:04:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:04:16 INFO - 'opt_config_files': (), 20:04:16 INFO - 'pip_index': False, 20:04:16 INFO - 'sps_profile': False, 20:04:16 INFO - 'sps_profile_interval': 0, 20:04:16 INFO - 'suite': 'dromaeojs', 20:04:16 INFO - 'system_bits': '32', 20:04:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:04:16 INFO - 'title': 'talos-linux64-ix-034', 20:04:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:04:16 INFO - 'use_talos_json': True, 20:04:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:04:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:04:16 INFO - 'work_dir': 'build'} 20:04:16 INFO - ##### 20:04:16 INFO - ##### Running clobber step. 20:04:16 INFO - ##### 20:04:16 INFO - Running pre-action listener: _resource_record_pre_action 20:04:16 INFO - Running main action method: clobber 20:04:16 INFO - rmtree: /builds/slave/test/build 20:04:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:04:16 INFO - Running post-action listener: _resource_record_post_action 20:04:16 INFO - ##### 20:04:16 INFO - ##### Finished clobber step (success) 20:04:16 INFO - ##### 20:04:16 INFO - ##### 20:04:16 INFO - ##### Running read-buildbot-config step. 20:04:16 INFO - ##### 20:04:16 INFO - Running pre-action listener: _resource_record_pre_action 20:04:16 INFO - Running main action method: read_buildbot_config 20:04:16 INFO - Using buildbot properties: 20:04:16 INFO - { 20:04:16 INFO - "project": "", 20:04:16 INFO - "product": "firefox", 20:04:16 INFO - "script_repo_revision": "production", 20:04:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:04:16 INFO - "repository": "", 20:04:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:04:16 INFO - "buildid": "20160718173017", 20:04:16 INFO - "pgo_build": "True", 20:04:16 INFO - "basedir": "/builds/slave/test", 20:04:16 INFO - "buildnumber": 909, 20:04:16 INFO - "slavename": "talos-linux64-ix-034", 20:04:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:04:16 INFO - "platform": "ubuntu64_hw", 20:04:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:04:16 INFO - "branch": "fx-team", 20:04:16 INFO - "repo_path": "integration/fx-team", 20:04:16 INFO - "revision": "62bb8900cfef139ac0ea2f9bc4db742166d6f9a5", 20:04:16 INFO - "stage_platform": "linux64-pgo", 20:04:16 INFO - "builduid": "cb019b03bb964ffdadab5a67dc7e6346", 20:04:16 INFO - "slavebuilddir": "test" 20:04:16 INFO - } 20:04:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:04:16 INFO - Running post-action listener: _resource_record_post_action 20:04:16 INFO - ##### 20:04:16 INFO - ##### Finished read-buildbot-config step (success) 20:04:16 INFO - ##### 20:04:16 INFO - ##### 20:04:16 INFO - ##### Running download-and-extract step. 20:04:16 INFO - ##### 20:04:16 INFO - Running pre-action listener: _resource_record_pre_action 20:04:16 INFO - Running main action method: download_and_extract 20:04:16 INFO - mkdir: /builds/slave/test/build/tests 20:04:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:16 INFO - https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:04:21 INFO - Downloaded 1361 bytes. 20:04:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:04:21 INFO - Using the following test package requirements: 20:04:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:04:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:04:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:04:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'jsshell-linux-x86_64.zip'], 20:04:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:04:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:04:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:04:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:04:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:04:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:04:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:21 INFO - https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:04:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:04:23 INFO - Downloaded 24333771 bytes. 20:04:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:04:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:04:24 INFO - Return code: 0 20:04:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:24 INFO - https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:04:27 INFO - Downloaded 24333771 bytes. 20:04:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:04:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:04:28 INFO - Return code: 0 20:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:28 INFO - https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:04:30 INFO - Downloaded 14403317 bytes. 20:04:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:04:30 INFO - Return code: 0 20:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:30 INFO - https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:04:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:04:32 INFO - Downloaded 60845246 bytes. 20:04:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:32 INFO - mkdir: /builds/slave/test/properties 20:04:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:04:32 INFO - Writing to file /builds/slave/test/properties/build_url 20:04:32 INFO - Contents: 20:04:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:32 INFO - Running post-action listener: _resource_record_post_action 20:04:32 INFO - Running post-action listener: set_extra_try_arguments 20:04:32 INFO - ##### 20:04:32 INFO - ##### Finished download-and-extract step (success) 20:04:32 INFO - ##### 20:04:32 INFO - ##### 20:04:32 INFO - ##### Running populate-webroot step. 20:04:32 INFO - ##### 20:04:32 INFO - Running pre-action listener: _resource_record_pre_action 20:04:32 INFO - Running main action method: populate_webroot 20:04:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:04:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:04:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:04:32 INFO - '--tppagecycles', 20:04:32 INFO - '7'], 20:04:32 INFO - 'tests': ['tsvgm']}}, 20:04:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:04:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:04:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:04:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:04:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:04:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:04:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['damp', 'tps']}, 20:04:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'tests': ['damp', 'tps']}, 20:04:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['dromaeo_dom']}, 20:04:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:04:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['basic_compositor_video']}, 20:04:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:04:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['a11yr', 20:04:32 INFO - 'ts_paint', 20:04:32 INFO - 'tpaint', 20:04:32 INFO - 'sessionrestore', 20:04:32 INFO - 'sessionrestore_no_auto_restore', 20:04:32 INFO - 'tabpaint']}, 20:04:32 INFO - 'other-e10s': {'tests': ['a11yr', 20:04:32 INFO - 'ts_paint', 20:04:32 INFO - 'tpaint', 20:04:32 INFO - 'sessionrestore', 20:04:32 INFO - 'sessionrestore_no_auto_restore', 20:04:32 INFO - 'tabpaint']}, 20:04:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:04:32 INFO - 'ts_paint', 20:04:32 INFO - 'tpaint', 20:04:32 INFO - 'sessionrestore', 20:04:32 INFO - 'sessionrestore_no_auto_restore', 20:04:32 INFO - 'tabpaint']}, 20:04:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:04:32 INFO - 'ts_paint', 20:04:32 INFO - 'tpaint', 20:04:32 INFO - 'sessionrestore', 20:04:32 INFO - 'sessionrestore_no_auto_restore', 20:04:32 INFO - 'tabpaint']}, 20:04:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['a11yr', 20:04:32 INFO - 'ts_paint', 20:04:32 INFO - 'tpaint', 20:04:32 INFO - 'sessionrestore', 20:04:32 INFO - 'sessionrestore_no_auto_restore', 20:04:32 INFO - 'tabpaint']}, 20:04:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['a11yr', 20:04:32 INFO - 'ts_paint', 20:04:32 INFO - 'tpaint', 20:04:32 INFO - 'sessionrestore', 20:04:32 INFO - 'sessionrestore_no_auto_restore', 20:04:32 INFO - 'tabpaint']}, 20:04:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['tsvgx', 20:04:32 INFO - 'tsvgr_opacity', 20:04:32 INFO - 'tart', 20:04:32 INFO - 'tscrollx', 20:04:32 INFO - 'cart']}, 20:04:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:04:32 INFO - 'tsvgr_opacity', 20:04:32 INFO - 'tart', 20:04:32 INFO - 'tscrollx', 20:04:32 INFO - 'cart']}, 20:04:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'talos_options': ['--disable-e10s'], 20:04:32 INFO - 'tests': ['tp5o']}, 20:04:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'tests': ['tp5o']}, 20:04:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'talos_options': ['--disable-e10s', 20:04:32 INFO - '--xperf_path', 20:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:04:32 INFO - 'tests': ['tp5n']}, 20:04:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:32 INFO - 'talos_options': ['--xperf_path', 20:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:04:32 INFO - 'tests': ['tp5n']}}, 20:04:32 INFO - 'talos.zip': {'path': '', 20:04:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:04:32 INFO - Running post-action listener: _resource_record_post_action 20:04:32 INFO - ##### 20:04:32 INFO - ##### Finished populate-webroot step (success) 20:04:32 INFO - ##### 20:04:32 INFO - ##### 20:04:32 INFO - ##### Running create-virtualenv step. 20:04:32 INFO - ##### 20:04:32 INFO - Running pre-action listener: _resource_record_pre_action 20:04:32 INFO - Running main action method: create_virtualenv 20:04:32 INFO - Creating virtualenv /builds/slave/test/build/venv 20:04:32 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 20:04:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:04:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:04:32 INFO - Using real prefix '/usr' 20:04:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:04:33 INFO - Installing distribute.............................................................................................................................................................................................done. 20:04:35 INFO - Installing pip.................done. 20:04:35 INFO - Return code: 0 20:04:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:35 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:35 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 20:04:35 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 20:04:35 INFO - Using env: {'DISPLAY': ':0', 20:04:35 INFO - 'HOME': '/home/cltbld', 20:04:35 INFO - 'LANG': 'en_US.UTF-8', 20:04:35 INFO - 'LANGUAGE': 'en_US:en', 20:04:35 INFO - 'LOGNAME': 'cltbld', 20:04:35 INFO - 'MAIL': '/var/mail/cltbld', 20:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:35 INFO - 'MOZ_NO_REMOTE': '1', 20:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:35 INFO - 'NO_EM_RESTART': '1', 20:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:35 INFO - 'PWD': '/builds/slave/test', 20:04:35 INFO - 'SHELL': '/bin/bash', 20:04:35 INFO - 'SHLVL': '1', 20:04:35 INFO - 'TERM': 'linux', 20:04:35 INFO - 'TMOUT': '86400', 20:04:35 INFO - 'USER': 'cltbld', 20:04:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:35 INFO - '_': '/tools/buildbot/bin/python'} 20:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:35 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 20:04:35 INFO - Cleaning up... 20:04:35 INFO - Return code: 0 20:04:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:35 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:35 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 20:04:35 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 20:04:35 INFO - Using env: {'DISPLAY': ':0', 20:04:35 INFO - 'HOME': '/home/cltbld', 20:04:35 INFO - 'LANG': 'en_US.UTF-8', 20:04:35 INFO - 'LANGUAGE': 'en_US:en', 20:04:35 INFO - 'LOGNAME': 'cltbld', 20:04:35 INFO - 'MAIL': '/var/mail/cltbld', 20:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:35 INFO - 'MOZ_NO_REMOTE': '1', 20:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:35 INFO - 'NO_EM_RESTART': '1', 20:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:35 INFO - 'PWD': '/builds/slave/test', 20:04:35 INFO - 'SHELL': '/bin/bash', 20:04:35 INFO - 'SHLVL': '1', 20:04:35 INFO - 'TERM': 'linux', 20:04:35 INFO - 'TMOUT': '86400', 20:04:35 INFO - 'USER': 'cltbld', 20:04:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:35 INFO - '_': '/tools/buildbot/bin/python'} 20:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:35 INFO - Downloading/unpacking psutil>=3.1.1 20:04:35 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 20:04:35 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 20:04:35 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 20:04:35 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 20:04:35 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 20:04:35 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 20:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:04:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:37 INFO - Installing collected packages: psutil 20:04:37 INFO - Running setup.py install for psutil 20:04:37 INFO - building 'psutil._psutil_linux' extension 20:04:37 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 20:04:38 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 20:04:38 INFO - building 'psutil._psutil_posix' extension 20:04:38 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 20:04:38 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 20:04:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:38 INFO - Successfully installed psutil 20:04:38 INFO - Cleaning up... 20:04:38 INFO - Return code: 0 20:04:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:04:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:38 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:38 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 20:04:38 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 20:04:38 INFO - Using env: {'DISPLAY': ':0', 20:04:38 INFO - 'HOME': '/home/cltbld', 20:04:38 INFO - 'LANG': 'en_US.UTF-8', 20:04:38 INFO - 'LANGUAGE': 'en_US:en', 20:04:38 INFO - 'LOGNAME': 'cltbld', 20:04:38 INFO - 'MAIL': '/var/mail/cltbld', 20:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:38 INFO - 'MOZ_NO_REMOTE': '1', 20:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:38 INFO - 'NO_EM_RESTART': '1', 20:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:38 INFO - 'PWD': '/builds/slave/test', 20:04:38 INFO - 'SHELL': '/bin/bash', 20:04:38 INFO - 'SHLVL': '1', 20:04:38 INFO - 'TERM': 'linux', 20:04:38 INFO - 'TMOUT': '86400', 20:04:38 INFO - 'USER': 'cltbld', 20:04:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:38 INFO - '_': '/tools/buildbot/bin/python'} 20:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:04:38 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 20:04:38 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 20:04:38 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 20:04:38 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 20:04:38 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 20:04:38 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 20:04:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:04:40 INFO - Installing collected packages: mozsystemmonitor 20:04:40 INFO - Running setup.py install for mozsystemmonitor 20:04:40 INFO - Successfully installed mozsystemmonitor 20:04:40 INFO - Cleaning up... 20:04:40 INFO - Return code: 0 20:04:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:04:40 INFO - Using env: {'DISPLAY': ':0', 20:04:40 INFO - 'HOME': '/home/cltbld', 20:04:40 INFO - 'LANG': 'en_US.UTF-8', 20:04:40 INFO - 'LANGUAGE': 'en_US:en', 20:04:40 INFO - 'LOGNAME': 'cltbld', 20:04:40 INFO - 'MAIL': '/var/mail/cltbld', 20:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:40 INFO - 'MOZ_NO_REMOTE': '1', 20:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:40 INFO - 'NO_EM_RESTART': '1', 20:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:40 INFO - 'PWD': '/builds/slave/test', 20:04:40 INFO - 'SHELL': '/bin/bash', 20:04:40 INFO - 'SHLVL': '1', 20:04:40 INFO - 'TERM': 'linux', 20:04:40 INFO - 'TMOUT': '86400', 20:04:40 INFO - 'USER': 'cltbld', 20:04:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:40 INFO - '_': '/tools/buildbot/bin/python'} 20:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:40 INFO - Downloading/unpacking jsonschema==2.5.1 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:04:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:42 INFO - Downloading functools32-3.2.3-2.tar.gz 20:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:04:43 INFO - warning: no files found matching '*.txt' 20:04:43 INFO - no previously-included directories found matching 'build' 20:04:43 INFO - no previously-included directories found matching 'dist' 20:04:43 INFO - no previously-included directories found matching '.git*' 20:04:43 INFO - Installing collected packages: jsonschema, functools32 20:04:43 INFO - Running setup.py install for functools32 20:04:43 INFO - warning: no files found matching '*.txt' 20:04:43 INFO - no previously-included directories found matching 'build' 20:04:43 INFO - no previously-included directories found matching 'dist' 20:04:43 INFO - no previously-included directories found matching '.git*' 20:04:43 INFO - Successfully installed jsonschema functools32 20:04:43 INFO - Cleaning up... 20:04:43 INFO - Return code: 0 20:04:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:43 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:43 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 20:04:43 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 20:04:43 INFO - Using env: {'DISPLAY': ':0', 20:04:43 INFO - 'HOME': '/home/cltbld', 20:04:43 INFO - 'LANG': 'en_US.UTF-8', 20:04:43 INFO - 'LANGUAGE': 'en_US:en', 20:04:43 INFO - 'LOGNAME': 'cltbld', 20:04:43 INFO - 'MAIL': '/var/mail/cltbld', 20:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:43 INFO - 'MOZ_NO_REMOTE': '1', 20:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:43 INFO - 'NO_EM_RESTART': '1', 20:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:43 INFO - 'PWD': '/builds/slave/test', 20:04:43 INFO - 'SHELL': '/bin/bash', 20:04:43 INFO - 'SHLVL': '1', 20:04:43 INFO - 'TERM': 'linux', 20:04:43 INFO - 'TMOUT': '86400', 20:04:43 INFO - 'USER': 'cltbld', 20:04:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:43 INFO - '_': '/tools/buildbot/bin/python'} 20:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:43 INFO - Downloading/unpacking blobuploader==1.2.4 20:04:43 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 20:04:43 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 20:04:43 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 20:04:43 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 20:04:43 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 20:04:43 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 20:04:45 INFO - Downloading blobuploader-1.2.4.tar.gz 20:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:04:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:04:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:46 INFO - Downloading docopt-0.6.1.tar.gz 20:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:04:46 INFO - Installing collected packages: blobuploader, requests, docopt 20:04:46 INFO - Running setup.py install for blobuploader 20:04:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:04:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:04:46 INFO - Running setup.py install for requests 20:04:46 INFO - Running setup.py install for docopt 20:04:46 INFO - Successfully installed blobuploader requests docopt 20:04:46 INFO - Cleaning up... 20:04:46 INFO - Return code: 0 20:04:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:46 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:46 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 20:04:46 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 20:04:46 INFO - Using env: {'DISPLAY': ':0', 20:04:46 INFO - 'HOME': '/home/cltbld', 20:04:46 INFO - 'LANG': 'en_US.UTF-8', 20:04:46 INFO - 'LANGUAGE': 'en_US:en', 20:04:46 INFO - 'LOGNAME': 'cltbld', 20:04:46 INFO - 'MAIL': '/var/mail/cltbld', 20:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:46 INFO - 'MOZ_NO_REMOTE': '1', 20:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:46 INFO - 'NO_EM_RESTART': '1', 20:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:46 INFO - 'PWD': '/builds/slave/test', 20:04:46 INFO - 'SHELL': '/bin/bash', 20:04:46 INFO - 'SHLVL': '1', 20:04:46 INFO - 'TERM': 'linux', 20:04:46 INFO - 'TMOUT': '86400', 20:04:46 INFO - 'USER': 'cltbld', 20:04:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:46 INFO - '_': '/tools/buildbot/bin/python'} 20:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:46 INFO - Running setup.py (path:/tmp/pip-l6A8ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:47 INFO - Running setup.py (path:/tmp/pip-R2wqtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:47 INFO - Running setup.py (path:/tmp/pip-aKf_VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:47 INFO - Running setup.py (path:/tmp/pip-Oqx9pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:47 INFO - Running setup.py (path:/tmp/pip-rqKWXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:47 INFO - Running setup.py (path:/tmp/pip-PRnMpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:47 INFO - Running setup.py (path:/tmp/pip-JNC7Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:47 INFO - Running setup.py (path:/tmp/pip-YQ5WJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:47 INFO - Running setup.py (path:/tmp/pip-qAqgAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:47 INFO - Running setup.py (path:/tmp/pip-zW4pvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:47 INFO - Running setup.py (path:/tmp/pip-yBJb1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:47 INFO - Running setup.py (path:/tmp/pip-rYjIyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:47 INFO - Running setup.py (path:/tmp/pip-SIyZ9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:47 INFO - Running setup.py (path:/tmp/pip-_ZngvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:48 INFO - Running setup.py (path:/tmp/pip-G41ZCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:48 INFO - Running setup.py (path:/tmp/pip-RRpktp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:48 INFO - Running setup.py (path:/tmp/pip-aegJZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:04:48 INFO - Running setup.py install for manifestparser 20:04:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Running setup.py install for mozcrash 20:04:48 INFO - Running setup.py install for mozdebug 20:04:48 INFO - Running setup.py install for mozdevice 20:04:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Running setup.py install for mozfile 20:04:48 INFO - Running setup.py install for mozhttpd 20:04:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Running setup.py install for mozinfo 20:04:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Running setup.py install for mozInstall 20:04:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:04:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Running setup.py install for mozleak 20:04:49 INFO - Running setup.py install for mozlog 20:04:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Running setup.py install for moznetwork 20:04:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Running setup.py install for mozprocess 20:04:49 INFO - Running setup.py install for mozprofile 20:04:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Running setup.py install for mozrunner 20:04:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Running setup.py install for mozscreenshot 20:04:49 INFO - Running setup.py install for moztest 20:04:49 INFO - Running setup.py install for mozversion 20:04:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:04:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:49 INFO - Cleaning up... 20:04:49 INFO - Return code: 0 20:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:50 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:50 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 20:04:50 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 20:04:50 INFO - Using env: {'DISPLAY': ':0', 20:04:50 INFO - 'HOME': '/home/cltbld', 20:04:50 INFO - 'LANG': 'en_US.UTF-8', 20:04:50 INFO - 'LANGUAGE': 'en_US:en', 20:04:50 INFO - 'LOGNAME': 'cltbld', 20:04:50 INFO - 'MAIL': '/var/mail/cltbld', 20:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:50 INFO - 'MOZ_NO_REMOTE': '1', 20:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:50 INFO - 'NO_EM_RESTART': '1', 20:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:50 INFO - 'PWD': '/builds/slave/test', 20:04:50 INFO - 'SHELL': '/bin/bash', 20:04:50 INFO - 'SHLVL': '1', 20:04:50 INFO - 'TERM': 'linux', 20:04:50 INFO - 'TMOUT': '86400', 20:04:50 INFO - 'USER': 'cltbld', 20:04:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:50 INFO - '_': '/tools/buildbot/bin/python'} 20:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:50 INFO - Running setup.py (path:/tmp/pip-It0wYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:50 INFO - Running setup.py (path:/tmp/pip-eBy2J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:50 INFO - Running setup.py (path:/tmp/pip-GVEBBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:50 INFO - Running setup.py (path:/tmp/pip-JQyezT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:50 INFO - Running setup.py (path:/tmp/pip-xxLa9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:50 INFO - Running setup.py (path:/tmp/pip-XINiVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:50 INFO - Running setup.py (path:/tmp/pip-km8piU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:50 INFO - Running setup.py (path:/tmp/pip-G9KDU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:50 INFO - Running setup.py (path:/tmp/pip-Nuehsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:50 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:50 INFO - Running setup.py (path:/tmp/pip-qJRlKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 20:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:50 INFO - Running setup.py (path:/tmp/pip-_Q8oTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:51 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)) 20:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:51 INFO - Running setup.py (path:/tmp/pip-4RgZro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:51 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)) 20:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:51 INFO - Running setup.py (path:/tmp/pip-tIAxw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:51 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)) 20:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:51 INFO - Running setup.py (path:/tmp/pip-xDxOqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:51 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)) 20:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:51 INFO - Running setup.py (path:/tmp/pip-gRBGim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:51 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)) 20:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:51 INFO - Running setup.py (path:/tmp/pip-RN6Um4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:51 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)) 20:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:51 INFO - Running setup.py (path:/tmp/pip-5wwvy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:51 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)) 20:04:51 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)) 20:04:51 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)) 20:04:51 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)) 20:04:51 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)) 20:04:51 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)) 20:04:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:53 INFO - Downloading blessings-1.6.tar.gz 20:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:53 INFO - Installing collected packages: blessings 20:04:53 INFO - Running setup.py install for blessings 20:04:53 INFO - Successfully installed blessings 20:04:53 INFO - Cleaning up... 20:04:53 INFO - Return code: 0 20:04:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:53 INFO - Reading from file tmpfile_stdout 20:04:53 INFO - Current package versions: 20:04:53 INFO - argparse == 1.2.1 20:04:53 INFO - blessings == 1.6 20:04:53 INFO - blobuploader == 1.2.4 20:04:53 INFO - docopt == 0.6.1 20:04:53 INFO - functools32 == 3.2.3-2 20:04:53 INFO - jsonschema == 2.5.1 20:04:53 INFO - manifestparser == 1.1 20:04:53 INFO - mozInstall == 1.12 20:04:53 INFO - mozcrash == 0.17 20:04:53 INFO - mozdebug == 0.1 20:04:53 INFO - mozdevice == 0.48 20:04:53 INFO - mozfile == 1.2 20:04:53 INFO - mozhttpd == 0.7 20:04:53 INFO - mozinfo == 0.9 20:04:53 INFO - mozleak == 0.1 20:04:53 INFO - mozlog == 3.2 20:04:53 INFO - moznetwork == 0.27 20:04:53 INFO - mozprocess == 0.23 20:04:53 INFO - mozprofile == 0.28 20:04:53 INFO - mozrunner == 6.12 20:04:53 INFO - mozscreenshot == 0.1 20:04:53 INFO - mozsystemmonitor == 0.3 20:04:53 INFO - moztest == 0.7 20:04:53 INFO - mozversion == 1.4 20:04:53 INFO - psutil == 3.1.1 20:04:53 INFO - requests == 1.2.3 20:04:53 INFO - wsgiref == 0.1.2 20:04:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:53 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 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04:53 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 20:04:53 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 20:04:53 INFO - Using env: {'DISPLAY': ':0', 20:04:53 INFO - 'HOME': '/home/cltbld', 20:04:53 INFO - 'LANG': 'en_US.UTF-8', 20:04:53 INFO - 'LANGUAGE': 'en_US:en', 20:04:53 INFO - 'LOGNAME': 'cltbld', 20:04:53 INFO - 'MAIL': '/var/mail/cltbld', 20:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:53 INFO - 'MOZ_NO_REMOTE': '1', 20:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:53 INFO - 'NO_EM_RESTART': '1', 20:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:53 INFO - 'PWD': '/builds/slave/test', 20:04:53 INFO - 'SHELL': '/bin/bash', 20:04:53 INFO - 'SHLVL': '1', 20:04:53 INFO - 'TERM': 'linux', 20:04:53 INFO - 'TMOUT': '86400', 20:04:53 INFO - 'USER': 'cltbld', 20:04:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:53 INFO - '_': '/tools/buildbot/bin/python'} 20:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 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)) 20:04:54 INFO - Cleaning up... 20:04:54 INFO - Return code: 0 20:04:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1443030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1704180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', '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 20:04: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', 'jsonschema'] in /builds/slave/test/build 20:04: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 jsonschema 20:04:54 INFO - Using env: {'DISPLAY': ':0', 20:04:54 INFO - 'HOME': '/home/cltbld', 20:04:54 INFO - 'LANG': 'en_US.UTF-8', 20:04:54 INFO - 'LANGUAGE': 'en_US:en', 20:04:54 INFO - 'LOGNAME': 'cltbld', 20:04:54 INFO - 'MAIL': '/var/mail/cltbld', 20:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:54 INFO - 'MOZ_NO_REMOTE': '1', 20:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:54 INFO - 'NO_EM_RESTART': '1', 20:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:54 INFO - 'PWD': '/builds/slave/test', 20:04:54 INFO - 'SHELL': '/bin/bash', 20:04:54 INFO - 'SHLVL': '1', 20:04:54 INFO - 'TERM': 'linux', 20:04:54 INFO - 'TMOUT': '86400', 20:04:54 INFO - 'USER': 'cltbld', 20:04:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:54 INFO - '_': '/tools/buildbot/bin/python'} 20:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:04:54 INFO - Cleaning up... 20:04:54 INFO - Return code: 0 20:04:54 INFO - Running post-action listener: _resource_record_post_action 20:04:54 INFO - Running post-action listener: _start_resource_monitoring 20:04:54 INFO - Starting resource monitoring. 20:04:54 INFO - ##### 20:04:54 INFO - ##### Finished create-virtualenv step (success) 20:04:54 INFO - ##### 20:04:54 INFO - ##### 20:04:54 INFO - ##### Running install step. 20:04:54 INFO - ##### 20:04:54 INFO - Running pre-action listener: _resource_record_pre_action 20:04:54 INFO - Running main action method: install 20:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:54 INFO - Reading from file tmpfile_stdout 20:04:54 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:04:54 INFO - Reading from file tmpfile_stdout 20:04:54 INFO - Output received: 20:04:54 INFO - Usage: mozinstall [options] installer 20:04:54 INFO - Options: 20:04:54 INFO - -h, --help show this help message and exit 20:04:54 INFO - -d DEST, --destination=DEST 20:04:54 INFO - Directory to install application into. [default: 20:04:54 INFO - "/builds/slave/test"] 20:04:54 INFO - --app=APP Application being installed. [default: firefox] 20:04:54 INFO - mkdir: /builds/slave/test/build/application 20:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:05:11 INFO - Reading from file tmpfile_stdout 20:05:11 INFO - Output received: 20:05:11 INFO - /builds/slave/test/build/application/firefox/firefox 20:05:11 INFO - Running post-action listener: _resource_record_post_action 20:05:11 INFO - ##### 20:05:11 INFO - ##### Finished install step (success) 20:05:11 INFO - ##### 20:05:11 INFO - ##### 20:05:11 INFO - ##### Running run-tests step. 20:05:11 INFO - ##### 20:05:11 INFO - Running pre-action listener: _resource_record_pre_action 20:05:11 INFO - Running main action method: run_tests 20:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:05:11 INFO - Python 2.7.3 20:05:11 INFO - Return code: 0 20:05:11 INFO - grabbing minidump binary from tooltool 20:05:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:11 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 0x17023b0>, '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 0x17032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:05:11 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 20:05:11 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 20:05:11 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 20:05:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:05:11 INFO - Return code: 0 20:05:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:05:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:05:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:05:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:05:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:05:11 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/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 20:05:11 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/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 20:05:11 INFO - Using env: {'DISPLAY': ':0', 20:05:11 INFO - 'HOME': '/home/cltbld', 20:05:11 INFO - 'LANG': 'en_US.UTF-8', 20:05:11 INFO - 'LANGUAGE': 'en_US:en', 20:05:11 INFO - 'LOGNAME': 'cltbld', 20:05:11 INFO - 'MAIL': '/var/mail/cltbld', 20:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:11 INFO - 'MOZ_NO_REMOTE': '1', 20:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:11 INFO - 'NO_EM_RESTART': '1', 20:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:11 INFO - 'PWD': '/builds/slave/test', 20:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:05:11 INFO - 'SHELL': '/bin/bash', 20:05:11 INFO - 'SHLVL': '1', 20:05:11 INFO - 'TERM': 'linux', 20:05:11 INFO - 'TMOUT': '86400', 20:05:11 INFO - 'USER': 'cltbld', 20:05:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907', 20:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:11 INFO - '_': '/tools/buildbot/bin/python'} 20:05:11 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/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 20:05:12 INFO - mozversion application_buildid: 20160718173017 20:05:12 INFO - mozversion application_changeset: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 20:05:12 INFO - mozversion application_display_name: Nightly 20:05:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:05:12 INFO - mozversion application_name: Firefox 20:05:12 INFO - mozversion application_remotingname: firefox 20:05:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:05:12 INFO - mozversion application_vendor: Mozilla 20:05:12 INFO - mozversion application_version: 50.0a1 20:05:12 INFO - mozversion platform_buildid: 20160718173017 20:05:12 INFO - mozversion platform_changeset: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 20:05:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:05:12 INFO - mozversion platform_version: 50.0a1 20:05:12 INFO - using testdate: 1468897512 20:05:12 INFO - actual date: 1468897512 20:05:12 INFO - starting webserver on 'localhost:41902' 20:05:12 INFO - SUITE-START | Running 2 tests 20:05:12 INFO - TEST-START | dromaeo_css 20:05:12 INFO - operating with platform_type : linux_ 20:05:12 INFO - Initialising browser for dromaeo_css test... 20:05:12 INFO - TEST-INFO | started process 2987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiclXiB/profile http://localhost:41902/getInfo.html) 20:05:16 INFO - PROCESS | 2987 | __metrics Screen width/height:1600/1200 20:05:16 INFO - PROCESS | 2987 | colorDepth:24 20:05:16 INFO - PROCESS | 2987 | Browser inner width/height: 1024/697 20:05:16 INFO - PROCESS | 2987 | __metrics 20:05:16 INFO - PROCESS | 2987 | 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" 20:05:16 INFO - PROCESS | 2987 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:05:17 INFO - PROCESS | 2987 | console.error: PushService: 20:05:17 INFO - PROCESS | 2987 | stateChangeProcessEnqueue: Error transitioning state 20:05:17 INFO - PROCESS | 2987 | UnknownError 20:05:17 INFO - TEST-INFO | 2987: exit 0 20:05:17 INFO - Browser initialized. 20:05:17 INFO - Running cycle 1/1 for dromaeo_css test... 20:05:17 INFO - TEST-INFO | started process 3070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiclXiB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:05:29 INFO - PROCESS | 3070 | RSS: Main: 158380032 20:05:29 INFO - PROCESS | 3070 | 20:06:21 INFO - PROCESS | 3070 | 1468897581076 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] 20:08:29 INFO - PROCESS | 3070 | Cycle 1(1): loaded http://localhost:41902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41902/tests/dromaeo/cssquery-ext.html) 20:08:30 INFO - PROCESS | 3070 | RSS: Main: 289705984 20:08:30 INFO - PROCESS | 3070 | 20:11:33 INFO - PROCESS | 3070 | Cycle 1(1): loaded http://localhost:41902/tests/dromaeo/cssquery-ext.html (next: http://localhost:41902/tests/dromaeo/cssquery-jquery.html) 20:11:33 INFO - PROCESS | 3070 | RSS: Main: 245829632 20:11:33 INFO - PROCESS | 3070 | 20:14:35 INFO - PROCESS | 3070 | Cycle 1(1): loaded http://localhost:41902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41902/tests/dromaeo/cssquery-mootools.html) 20:14:36 INFO - PROCESS | 3070 | RSS: Main: 246960128 20:14:36 INFO - PROCESS | 3070 | 20:17:38 INFO - PROCESS | 3070 | Cycle 1(1): loaded http://localhost:41902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41902/tests/dromaeo/cssquery-prototype.html) 20:17:38 INFO - PROCESS | 3070 | RSS: Main: 238563328 20:17:38 INFO - PROCESS | 3070 | 20:20:41 INFO - PROCESS | 3070 | Cycle 1(1): loaded http://localhost:41902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41902/tests/dromaeo/cssquery-yui.html) 20:20:42 INFO - PROCESS | 3070 | RSS: Main: 220471296 20:20:42 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | Cycle 1(1): loaded http://localhost:41902/tests/dromaeo/cssquery-yui.html (next: http://localhost:41902/tests/dromaeo/cssquery-dojo.html) 20:23:45 INFO - PROCESS | 3070 | RSS: Main: 291405824 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | __start_tp_report 20:23:45 INFO - PROCESS | 3070 | _x_x_mozilla_page_load 20:23:45 INFO - PROCESS | 3070 | _x_x_mozilla_page_load_details 20:23:45 INFO - PROCESS | 3070 | |i|pagename|runs| 20:23:45 INFO - PROCESS | 3070 | |0;dojo.html;3056.083175047486;3074.6464156621996;3085.8457077146145;3102.844857757113;3108.70467305606;5315.893682126365;5373.382061062979;5399.244105825188;5510.063289240828;5524.14375771755;5462.808801691942;5494.1758736189595;5513.09034009388;5574.386817450078;5595.468430499106;4873.951260487394;4890.021995600876;4892.461829198785;4973.5772459341;4989.925151122718;4942.9258561121615;5079.695218286896;5094.821681241157;5098.158803797388;5151.665141765792;4873.269009648546;4916.434610019822;4993.126202914494;5008.524190201925;5061.417936937262;4956.083124621957;4988.82539111133;4996.675216110941;5012.77442515084;5051.6716413433005;4934.777934992934;4949.282354058641;4962.6526143169995;4971.627127965381;5009.398872135367;5322.5209731124;5440.863978400532;5484.643498172606;5490.835274941758;5498.670079795185;5956.344802071769;5966.31387390447;5986.5210783137245;5988.61074030191;5989.940100598982;5978.252718410199;6016.458518733335;6024.0662697282;6029.306629737593;6041.6979151042715;5369.973150134263;5392.137258038695;5459.972700136514;5462.754176062087;5600.215969764236;5977.462028417463;5982.042873140276;6032.638041717511;6044.909326360108;6045.425684559959;5804.477597016289;5813.59304848665;5815.127730840323;5817.0401883689565;5821.825345239649;5689.061304884731;5754.510866576305;5764.106563482667;5806.216160818235;5882.529397648178;5756.740946657411;5792.739326730307;5802.709864506842;5805.187273781674;5851.38560451155;5618.6628802272;5737.5983681141915;5775.88448231033;5780.913286300709;5793.565482588822;4334;4374.606285434326;4428.734275943454;4444.044530425974;4478.507364190002;3901.5708272090046;3902.926695158854;3904.0869973712674;3945.861894833667;3947.6644485219076;5413.53984911287;5496.862578435571;5504.256925315111;5504.284443022461;5509.283793106951;5851.61964472308;5885.764569417261;5895.64626122434;5939.851503712442;5964.940350596526;5594.13290939905;5599.524040456607;5605.159226116115;5607.243022192033;5607.943920560824;4738.739369334719;4956.727379994135;4962.03240368132;4967.105920934267;5007.474215207423;5958.612690175125;6031.969840150771;6037.366076561898;6052.182955300978;6065.878682426415;5869.119632055055;5870.735816888336;5871.823845284648;5873.911891321548;5893.5874488785375;5848.385919478394;5986.700664966821;6034.728437220423;6056.939430605637;6057.787977420945;5771.3651498335985;5801.796937107181;5823.18475413451;5824.126381042877;5878.970605147118;5851.180834683063;5854.590178687451;5907.881842363215;5921.467067963904;5923.614965027259;5618.7190640467;5705.429457054262;5748.9425105748405;5776.653400795965;5779.595428319977;5796.391378905154;5798.710064496674;5801.100829371454;5803.361630220588;5853;5718.228039214653;5721.828345149652;5723.255976723;5724.79963201286;5728.885422291614;5629.324481062299;5705.657660540381;5745.913811292918;5764.19301297827;5815.534757219328;5512.476314750093;5590.720463976703;5591.245181900392;5639.238702775073;5661.377248502744 20:23:45 INFO - PROCESS | 3070 | |1;ext.html;570.2301892445199;612.7855250662267;626.4424662050773;629.1820633176872;640.1741753138451;30930.690693093064;42624;44198.33702494457;44218.778906105465;47048.76475617626;44880.775596122054;45515.77242113793;45529.77235113828;45531.54468455315;45538;8040.638171282307;8250.092489826115;8251.83496330076;8983.595738191798;9090.2273306769;8334.374921880853;10760.73098172548;11047.116230701524;11049.779004419906;11413.201075924688;11273.830892536618;11315.434228288552;11323.150763692714;11330.263532870336;11342.886571134306;8177.182281771835;10745.78508429827;11000.009999100079;11103.666889993314;11123.443827808618;10700.143988480902;11074.723131921686;11079.778404431867;11090.279131856403;11095.167862410271;43693;43789.78105109486;43854.56145438569;44054.55945440569;44055;3636.6181550937035;3921.29416704993;4227.0489139943575;4294.162638285536;4471.195184866723;32712.345753084806;33144.66855331464;33412.665873341444;33458.1635459113;34051.14872128192;4350.586694264071;4493.865184044484;4510.413646225969;4609.953900460986;4616;251291.99999999817;251408;252145;252850;253865;57890;57924.420755792744;58246.708766456744;58274.41725582775;58336;61669;61762.38237617656;61862.381376185665;61930.380696192464;61942.38057619456;16317.102559359111;16629.251683674265;16648.417305394254;16651.750223746654;16662.08358540292;11452.656420307405;11671.782361351316;12022.879771202352;12884.291363975071;12984.480620775252;16444.095574743264;16500.504984850475;16596.17019149062;16762.664746705;16832;5964.194833697396;5980.611260268156;6036;6072.392760723892;6191.535634827406;1015.8069966706303;1041.9479026048666;1127.520803658442;1128.2891778179694;1165.184370940328;33327.50008749822;33613.83193084068;33716.66283337184;33780.662193378244;34322.48516272258;1132.6375559820779;1143.3540049871797;1151.2631915574038;1208.3595694282044;1237.3318408059547;17007;17704.645907082046;17755.964090632406;17881.514885465855;17895.552611184823;528854;578461;585899;594526;596630;58632.41367586355;58639;59089.70455147783;63998.68000659967;64212.67893660502;1242.571312897031;1432.3124900048035;1438.3096113865404;1446.6021843992987;1483.9777403338742;30977.845110774302;34831;34862;34975.300493990486;35037.299254015285;51446;51926.48073519216;51986.220206696176;52048.479515204366;52227.73886130545;433540;436750;439754;440450;441369;37574.624253757116;44595.777021114685;46011;46302.536974629824;49494;49373.753131234116;49938;50321;51085.23372149347;51403.485965141364;42160.36759448672;42808.78595607002;43254.351184732885;43726.56273437225;44567.77716111398;42496.57503424926;42823.5717642832;42930.570694292655;43385.13229735451;43472.071516032425;43611.56388436075;43800;43816.342754858066;43934.340984885894;44083.33874991813;36234.456483152244;37962.43056354212;38516.6148338513;39141;39145;29135.417291654474;29383.7061629381;29559.85220073886;29812;29926.102216933527 20:23:45 INFO - PROCESS | 3070 | |2;jquery.html;400.45738024976174;403.1292408397861;405.98782036538915;407.78998815609947;415.36656598687;18842.717359239607;20364.59270814583;20371.388858334274;20398.388048358553;21500.354989350304;19857.900710496462;20442.488937776525;20444.795552044514;20450.284240051602;20455.693164602504;5508.256385387981;5808.12878068289;5817.650940943557;5825;5828.737706803183;5502.724863756816;5570.275864137677;5660.688662123582;5663.2637757091525;5667.943320566783;5760.934227167966;5762.366139724627;5778.335491418498;5785.016547186989;5798.217240672498;5548.361938377098;5724.513416359614;5776.682282474483;5781.913271300934;5782.24830771999;5055.165897626887;5075.3402057732255;5089.160288552384;5094.5160209780015;5094.7197904115255;22459;23455.882720586458;23486.64770028451;23669;24190;2320.4314942839114;2335.089315167086;2336.7780060894356;2876.3528206153655;3000.9549856752164;10370.844437333446;10718.517666705016;10730.678079657622;11867.287962722265;12600.991920646326;1948.2012374926353;1970.7635083790037;1982.5241941933975;2013.8489613279062;2086.8539202255847;83443;87444.99999999936;87557;88418;88538;10563;10934.56261749537;10996.175286853519;11008.284461509977;11149.721256968478;14741.189234591986;14750.262486875614;14822.62943426423;14846.18345990981;14855;7681.654325555363;8128.268455839003;8192.467489613156;8228.753137405887;8264.876026859602;7805.102413222438;7826.726064587712;7892.84214315722;8055.959720201361;8064.153263907323;4585.335126406719;4594.977025114853;4610.654200934943;4659.324397962277;4724.244120940633;1750.7282231355452;1938.8158124978104;2009.1762377425478;2029.0159272752999;2072.616565935307;934.8644446555212;1012.4380968562518;1048.397171626318;1117.9552817887193;1145.181195445244;19707.408777736404;20713;20844.270450534463;20948.695643479205;21022.2642207522;1013.9758843567902;1032.8052887613821;1041.9322744021615;1044.2429238801808;1092.5356723392686;10139.875743136328;11601.361925094032;11681.182317237712;11707.648770536898;11726.530938762355;508664;520485;522834;525738;526003;92915;93216.53391732997;95703;96197.51901240449;97863.51068244613;998.1036031540132;1007.315025782475;1015.0661391519819;1020.7652239984845;1030.0935177044303;17910.731339030186;18273.543161420537;18356.265749369875;18680;18927.432177034712;41025.79487102665;46097.53902460932;46099.77301588857;46753.53246467628;46847;59983.40016599778;60069.69965150321;61194.38805611887;62034;62581.68709156425;8817.691380801642;8967.730968070968;8998.460092394478;9069.546522673973;9079.137481939206;10325.896741032493;12625.179363341353;13489.392977315849;14211.431542738175;14327.713445730818;11869.762604747684;11909.22590031645;12155.635330940086;12156.878431215575;12316.50733970667;10078.798424031625;10151.593936242763;11215.878412159045;11762.882371176178;11824.70438239051;12260.75478490443;12343.259404435763;12430.316332601793;12506.999440044956;12702.682432939251;8753.08092650288;9056;9063.773405664911;9207.125323094295;9296.07039296092;11605.419729013347;11855.347955862166;11996.700082497659;11997.940010299893;12001.339926304137 20:23:45 INFO - PROCESS | 3070 | |3;mootools.html;1460.7370673278808;1493.9178345191015;1628.3079691131265;1735.4706814421613;1789.5078853315329;8772.16664416881;9244.67643632473;9345.345825792198;9349.626014959393;9353.298502612306;7980.600969951493;8222.34221262299;8231.711890083849;8319.084900660922;9140.765996590459;2280.703508543891;2380.2264264114146;2388.5461762265113;2403;2407.7351491336026;2343.261872510154;2365.6215005599106;2369.5024044950583;2376.346504711201;2391.0674836813655;2093.3510611710344;2300.7584203658625;2312.433453803812;2320.3155069254612;2320.5938960681815;2352.364861487406;2370.2178281167176;2382.5115851250453;2383.940401489959;2387.6657267982496;2203.3610253026764;2204.922827701023;2216.445888527868;2223.7442694090223;2239.876806775627;9232.492212928286;9370.062993700643;9370.437773733598;9379.108984646447;9388.436693798325;5385.973070134663;5476;5476.096444086721;5484;5486.753096110685;3545.840437180307;3597.3165098631175;3682.3371793077235;3685.3919103347916;3695.8521659133603;1222;1250.7123361626786;1252.7431876465303;1279.7952327627536;1293.230527835936;13008.739825203444;13046.869531304661;13058.21650700961;13067.150635208682;13089.41097650608;4779.832705855348;4786.497417771084;4888.560029597354;4971.577415919615;5000.749962501933;10977.066949309397;11001.22991390595;11005.834912476319;11007.504662290215;11027.779444411068;5549.112142057252;5561.972190139023;5570.220169176318;5570.442955704397;5578.107502799533;5002.374703162105;5026.145555255615;5040.8487745366965;5132.6150538709;5142.9742851286255;4064.9187016260103;4129.846349812894;4137.565555616678;4164.104717485755;4179.1432756284885;1305.5104335874048;1308.1228437192658;1318.637374721959;1321.1610627251764;1336.4052996416697;920.3097676742309;997.7904640025531;1005.2812239248826;1019.2814066083394;1037.865077539915;6440.77457289002;6497.285298617148;6525.641089740015;6638.402543771083;6688.063671086052;951.7573018880141;994.418265314799;1000.7648202672366;1007.6070332570304;1031.159604921986;4419.734815911055;4534.36518887356;4575.565321294472;4576.610988065985;4605.286180642006;11436.199466037464;11603.245789023686;11645.359505227125;11682.883171168349;11703.88296117045;10864.076553493042;11437;11439.313641181556;11606.129540284512;11613.825792613117;8502.532360720219;8563.400561960603;8655.350848686374;8663.566821659018;8699.478031318142;6364.77723279683;6437.098806167234;6552.6068435894;6585.209774827052;6648.069270302259;9921.503924803876;10497.317674351143;10599.258051936291;10662.520186591466;10680.092192163753;9460.479673617741;10325.845112323172;10412.062914337746;10716.624918127829;10739.516721747696;7935.2064793520185;8266.586670666564;8354.582270886553;8375.162483751576;8386.951631046119;9068.90931090707;9164.862527061967;9174.67888623895;9175.22010629104;9183.586738596645;8016.599170041592;8285.50286982783;8321.16788321163;8432.19894110083;8436.24073833358;8110.918890811253;8116.59417029158;8182.099969003286;8308.5430301334;8356.289715374262;7267.127944646676;7469.775906722807;7523.510971786816;7561.962190189014;7563.9621801890635;5175.534201921845;5266.868328291824;5322.973385133049;5340.385855626652;5401.8919621606565;5508.476694713996;5680.914786278292;5752.626079304831;5787.94212057874;5824.068149096124 20:23:45 INFO - PROCESS | 3070 | |4;prototype.html;327.4809427058113;333.13717471748174;339.9541061956636;341.05357632569616;342.9657034296572;5448.536874365679;5478.315210598676;5483.890322193553;5516.531094856932;5527.613067085305;5382.784688612451;5386.761044959661;5436.130219164935;5439.755211015504;5447.319085114361;4041.151358214771;4110.856120035799;4261.4673165854265;4265.208612382791;4302.247106756321;4223.0920352124285;4242.936355954663;4272.700910936236;4274.316109422493;4285.614294713475;4018.598140185987;4226.408302837605;4233.640140588038;4241.384999175118;4258.808353624095;3973.9403908941244;4144.720403777925;4210.421092090466;4255.446791917062;4261.382099595541;3770.264798364293;3775.1505911170043;3790.8104594770152;3796.8101594920417;3797.39241721326;5166.535011848951;5306.283651707009;5335;5342.877995620925;5351.143816989302;4833.839878429187;4857.73282469464;4865.732384718839;4872.4153101628035;4902.632302577321;5546.27898373213;5546.944530554683;5557.166425036236;5618.522425593829;5654.688992105433;3901.453796468497;4047.9392809107885;4064.7357921734992;4098.118904435561;4111.527174374955;5866.853328666774;5881.558883083786;5894.705264736746;5901.822945311647;5915.5267578593175;4173.5409104998425;4176.7076304658385;4183.477065366829;4188.748675079444;4193.559676234013;4076.286649836267;4209.852655157116;4220.092680073799;4237.63980061692;4242.596953289494;4767.3314339980725;4785.545373189541;4793.257045158006;4825.227963525889;4825.420949486014;5683.431656834284;5712.428757124254;5720.170575266563;5729.4843464088435;5780.306363236438;1370.7327071221016;1439.3954539093606;1439.6688761584894;1444.949426770058;1475.5720840956217;924.3390975452584;928.2481190235795;932.8041111366554;937.8733870927474;956.153803883568;5357.383900851452;5397.382269599241;5398.8920221595345;5483.862903427446;5584.664920104726;5808.303003639506;5837.854053648608;5845.620034697731;5864.44287792659;5868.853278668067;5308.787648494017;5538.86152846174;5547.750351234205;5574.470425309589;5603.103503439512;3088.366884788613;3099.729111064453;3119.3293441909645;3134.326119884236;3138.435081685273;5758.7696492140685;5998.790042348497;6008.206184124316;6048.969755151196;6090.147379366892;6004.699765011732;6011.699415029231;6016.548758843104;6019.789307374221;6066.514678825683;6042.154098426224;6091.568481406865;6101.816945491642;6119.755209791648;6131.570790044743;5577.414371490935;5884.47039766423;5886.882262354815;5901.3213480450295;5963.7912673056235;5803.187553742564;5825.184474173704;5830.18377427169;5861.6189947653265;5867.73595188209;5796.594238403271;6085.817425477243;6105.206323177958;6116.5106791457465;6144.201253836973;4156.667466602604;4167.229062623424;4177.665786737114;4184.8744537663915;4204.453421055366;5930.169776231245;5960.6125601837475;5968.9856622405405;5969.074793407029;5980.611260268069;5715.457031581993;5767.519966414482;5773.278340207474;5818.76724930998;5855.94144058571;5674.829755107354;5738.987031808334;5755.942440575708;5775.624584402;5790.7973220937065;5175.645081487839;5412.83761487156;5685.260916080883;5698.886022279614;5753.935521928456;5682.9431705684065;5732.197492350991;5740.282464691913;5746.166805813217;5754;5640.746166422603;5645.802396916089;5651.378348381757;5667.914981275367;5674.517665998436 20:23:45 INFO - PROCESS | 3070 | |5;yui.html;751.1286907187664;782.9960850195748;813.6460639621761;817.6851912013875;850.502456063203;16126.758098628516;16825.242864071115;16848.663026739458;16857.83142168578;16861.156942152906;15209.23953802311;15313.923430382833;15316.46392376267;15319.77020344693;15334.233288335594;662.7978466567707;787.9251471110235;811.2536466450879;814.3647954595425;815.9224873636995;816.1797393619404;818.8198596308803;822.4325215601216;822.7613991942329;823.185046803663;698.7344808972583;870.6169285514385;871.8910136232971;872.2585802068223;872.2934423117264;817.599376305609;850.9361797865123;855.7689423855555;856.772955166875;856.8286342731416;624.8156793745856;628.8553632664467;629.4555209743585;629.672570263465;629.6757170057424;15302.464413745465;15428.997115187589;15485.303161357766;15503;15504.612384690361;14305.928470357685;14369.71260574793;14379.640508987255;14515.854841451555;14582.854171458363;12712.872871271262;12820;12877.871221287762;12890.355482225945;13260.138091024053;4452.443444569429;4465.709728867613;4471.0610771737975;4497.347884556753;4643.605293550052;78833;78870.6056469714;79374.20625793784;79410.60294698547;79585;11486.712832179262;11669.941650291694;11735.647930562096;11844.170908036527;11929.343886086348;21313.929603453827;21583.67624485634;21665.56668866614;21687.78312216889;21956.706494025704;8639.913600864036;8732.738017859474;8790.560471976503;8792.47245165292;8802.207801297915;4701.48283688794;4710.740909250024;4757.048590281957;4793.664443488992;5010.674306170087;3540.097275194809;3645.2345007548183;3646.85412583499;3651.397519409321;3651.543557055368;564.6499170514307;617.062065660194;643.3952085040141;701.8912068629371;705.5978092487233;692.8302565871293;750.2010358967682;760.1638197982286;772.5133166105318;785.3756263770316;10133.442660653734;10161.288709790244;10288.092476340718;10421.53103110362;10880.292780969212;642.5534253693731;710.4281053751677;741.6625435426868;744.8473063022068;768.5657603454031;4994.800207991712;5042.596592272683;5082.466341034212;5096.872578185575;5100.872478188001;75260.24739752641;75856.62071689716;122608;124227;129893;101484.49257753664;104492;104915.4754226224;107914;108120.45939770408;55472.72263638656;55545;66737;88752;89437;9581.374079191943;9659.806803863743;9742.61029558838;9753.951230244087;9877.617133601445;53166;53421.46578534165;55116;55585.722071389384;56366.71816640891;79230;80103;80137.3835139787;81906;85530.57234713787;11305.943470282926;12150.21023633461;12647.304398258184;12756.808647870475;12944.490141827986;13952.651183720489;14288.28558572088;14309.069910455786;14406.855931440552;14892.255387230378;13375.53185638498;13412.12821166621;13703.246321452416;13941.372638231102;14389.568312950629;12970.870291297344;13412;13528.255945922676;13645.727085458037;14038.087524310888;13292.468301268227;13463.730725385241;13517.86482135166;13799.586012419644;13835.930820345833;10352.107066040086;10398.100712232912;10465.319754215952;10492.895071049192;10647.361158330215;11058.502367393647;11290.49192786343;11441.289821444761;11510.194286399872;11514 20:23:45 INFO - PROCESS | 3070 | __end_tp_report 20:23:45 INFO - PROCESS | 3070 | __start_cc_report 20:23:45 INFO - PROCESS | 3070 | _x_x_mozilla_cycle_collect,1174 20:23:45 INFO - PROCESS | 3070 | __end_cc_report 20:23:45 INFO - PROCESS | 3070 | __startTimestamp1468898625425__endTimestamp 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | ------- Summary: start ------- 20:23:45 INFO - PROCESS | 3070 | Number of tests: 6 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | [#0] dojo.html Cycles:165 Average:5438.96 Median:5661.38 stddev:643.56 (11.4%) stddev-sans-first:617.78 20:23:45 INFO - PROCESS | 3070 | Values: 3056.1 3074.6 3085.8 3102.8 3108.7 5315.9 5373.4 5399.2 5510.1 5524.1 5462.8 5494.2 5513.1 5574.4 5595.5 4874.0 4890.0 4892.5 4973.6 4989.9 4942.9 5079.7 5094.8 5098.2 5151.7 4873.3 4916.4 4993.1 5008.5 5061.4 4956.1 4988.8 4996.7 5012.8 5051.7 4934.8 4949.3 4962.7 4971.6 5009.4 5322.5 5440.9 5484.6 5490.8 5498.7 5956.3 5966.3 5986.5 5988.6 5989.9 5978.3 6016.5 6024.1 6029.3 6041.7 5370.0 5392.1 5460.0 5462.8 5600.2 5977.5 5982.0 6032.6 6044.9 6045.4 5804.5 5813.6 5815.1 5817.0 5821.8 5689.1 5754.5 5764.1 5806.2 5882.5 5756.7 5792.7 5802.7 5805.2 5851.4 5618.7 5737.6 5775.9 5780.9 5793.6 4334.0 4374.6 4428.7 4444.0 4478.5 3901.6 3902.9 3904.1 3945.9 3947.7 5413.5 5496.9 5504.3 5504.3 5509.3 5851.6 5885.8 5895.6 5939.9 5964.9 5594.1 5599.5 5605.2 5607.2 5607.9 4738.7 4956.7 4962.0 4967.1 5007.5 5958.6 6032.0 6037.4 6052.2 6065.9 5869.1 5870.7 5871.8 5873.9 5893.6 5848.4 5986.7 6034.7 6056.9 6057.8 5771.4 5801.8 5823.2 5824.1 5879.0 5851.2 5854.6 5907.9 5921.5 5923.6 5618.7 5705.4 5748.9 5776.7 5779.6 5796.4 5798.7 5801.1 5803.4 5853.0 5718.2 5721.8 5723.3 5724.8 5728.9 5629.3 5705.7 5745.9 5764.2 5815.5 5512.5 5590.7 5591.2 5639.2 5661.4 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | [#1] ext.html Cycles:180 Average:59991.47 Median:42716.39 stddev:117785.45 (275.7%) stddev-sans-first:118031.38 20:23:45 INFO - PROCESS | 3070 | Values: 570.2 612.8 626.4 629.2 640.2 30930.7 42624.0 44198.3 44218.8 47048.8 44880.8 45515.8 45529.8 45531.5 45538.0 8040.6 8250.1 8251.8 8983.6 9090.2 8334.4 10760.7 11047.1 11049.8 11413.2 11273.8 11315.4 11323.2 11330.3 11342.9 8177.2 10745.8 11000.0 11103.7 11123.4 10700.1 11074.7 11079.8 11090.3 11095.2 43693.0 43789.8 43854.6 44054.6 44055.0 3636.6 3921.3 4227.0 4294.2 4471.2 32712.3 33144.7 33412.7 33458.2 34051.1 4350.6 4493.9 4510.4 4610.0 4616.0 251292.0 251408.0 252145.0 252850.0 253865.0 57890.0 57924.4 58246.7 58274.4 58336.0 61669.0 61762.4 61862.4 61930.4 61942.4 16317.1 16629.3 16648.4 16651.8 16662.1 11452.7 11671.8 12022.9 12884.3 12984.5 16444.1 16500.5 16596.2 16762.7 16832.0 5964.2 5980.6 6036.0 6072.4 6191.5 1015.8 1041.9 1127.5 1128.3 1165.2 33327.5 33613.8 33716.7 33780.7 34322.5 1132.6 1143.4 1151.3 1208.4 1237.3 17007.0 17704.6 17756.0 17881.5 17895.6 528854.0 578461.0 585899.0 594526.0 596630.0 58632.4 58639.0 59089.7 63998.7 64212.7 1242.6 1432.3 1438.3 1446.6 1484.0 30977.8 34831.0 34862.0 34975.3 35037.3 51446.0 51926.5 51986.2 52048.5 52227.7 433540.0 436750.0 439754.0 440450.0 441369.0 37574.6 44595.8 46011.0 46302.5 49494.0 49373.8 49938.0 50321.0 51085.2 51403.5 42160.4 42808.8 43254.4 43726.6 44567.8 42496.6 42823.6 42930.6 43385.1 43472.1 43611.6 43800.0 43816.3 43934.3 44083.3 36234.5 37962.4 38516.6 39141.0 39145.0 29135.4 29383.7 29559.9 29812.0 29926.1 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | [#2] jquery.html Cycles:180 Average:30505.88 Median:2335.93 stddev:85894.92 (3677.1%) stddev-sans-first:86106.13 20:23:45 INFO - PROCESS | 3070 | Values: 400.5 403.1 406.0 407.8 415.4 18842.7 20364.6 20371.4 20398.4 21500.4 19857.9 20442.5 20444.8 20450.3 20455.7 5508.3 5808.1 5817.7 5825.0 5828.7 5502.7 5570.3 5660.7 5663.3 5667.9 5760.9 5762.4 5778.3 5785.0 5798.2 5548.4 5724.5 5776.7 5781.9 5782.2 5055.2 5075.3 5089.2 5094.5 5094.7 22459.0 23455.9 23486.6 23669.0 24190.0 2320.4 2335.1 2336.8 2876.4 3001.0 10370.8 10718.5 10730.7 11867.3 12601.0 1948.2 1970.8 1982.5 2013.8 2086.9 83443.0 87445.0 87557.0 88418.0 88538.0 10563.0 10934.6 10996.2 11008.3 11149.7 14741.2 14750.3 14822.6 14846.2 14855.0 7681.7 8128.3 8192.5 8228.8 8264.9 7805.1 7826.7 7892.8 8056.0 8064.2 4585.3 4595.0 4610.7 4659.3 4724.2 1750.7 1938.8 2009.2 2029.0 2072.6 934.9 1012.4 1048.4 1118.0 1145.2 19707.4 20713.0 20844.3 20948.7 21022.3 1014.0 1032.8 1041.9 1044.2 1092.5 10139.9 11601.4 11681.2 11707.6 11726.5 508664.0 520485.0 522834.0 525738.0 526003.0 92915.0 93216.5 95703.0 96197.5 97863.5 998.1 1007.3 1015.1 1020.8 1030.1 17910.7 18273.5 18356.3 18680.0 18927.4 41025.8 46097.5 46099.8 46753.5 46847.0 59983.4 60069.7 61194.4 62034.0 62581.7 8817.7 8967.7 8998.5 9069.5 9079.1 10325.9 12625.2 13489.4 14211.4 14327.7 11869.8 11909.2 12155.6 12156.9 12316.5 10078.8 10151.6 11215.9 11762.9 11824.7 12260.8 12343.3 12430.3 12507.0 12702.7 8753.1 9056.0 9063.8 9207.1 9296.1 11605.4 11855.3 11996.7 11997.9 12001.3 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | [#3] mootools.html Cycles:180 Average:6111.58 Median:4837.53 stddev:3474.51 (71.8%) stddev-sans-first:3466.68 20:23:45 INFO - PROCESS | 3070 | Values: 1460.7 1493.9 1628.3 1735.5 1789.5 8772.2 9244.7 9345.3 9349.6 9353.3 7980.6 8222.3 8231.7 8319.1 9140.8 2280.7 2380.2 2388.5 2403.0 2407.7 2343.3 2365.6 2369.5 2376.3 2391.1 2093.4 2300.8 2312.4 2320.3 2320.6 2352.4 2370.2 2382.5 2383.9 2387.7 2203.4 2204.9 2216.4 2223.7 2239.9 9232.5 9370.1 9370.4 9379.1 9388.4 5386.0 5476.0 5476.1 5484.0 5486.8 3545.8 3597.3 3682.3 3685.4 3695.9 1222.0 1250.7 1252.7 1279.8 1293.2 13008.7 13046.9 13058.2 13067.2 13089.4 4779.8 4786.5 4888.6 4971.6 5000.7 10977.1 11001.2 11005.8 11007.5 11027.8 5549.1 5562.0 5570.2 5570.4 5578.1 5002.4 5026.1 5040.8 5132.6 5143.0 4064.9 4129.8 4137.6 4164.1 4179.1 1305.5 1308.1 1318.6 1321.2 1336.4 920.3 997.8 1005.3 1019.3 1037.9 6440.8 6497.3 6525.6 6638.4 6688.1 951.8 994.4 1000.8 1007.6 1031.2 4419.7 4534.4 4575.6 4576.6 4605.3 11436.2 11603.2 11645.4 11682.9 11703.9 10864.1 11437.0 11439.3 11606.1 11613.8 8502.5 8563.4 8655.4 8663.6 8699.5 6364.8 6437.1 6552.6 6585.2 6648.1 9921.5 10497.3 10599.3 10662.5 10680.1 9460.5 10325.8 10412.1 10716.6 10739.5 7935.2 8266.6 8354.6 8375.2 8387.0 9068.9 9164.9 9174.7 9175.2 9183.6 8016.6 8285.5 8321.2 8432.2 8436.2 8110.9 8116.6 8182.1 8308.5 8356.3 7267.1 7469.8 7523.5 7562.0 7564.0 5175.5 5266.9 5323.0 5340.4 5401.9 5508.5 5680.9 5752.6 5787.9 5824.1 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | [#4] prototype.html Cycles:180 Average:4810.42 Median:5522.07 stddev:1426.09 (25.8%) stddev-sans-first:1389.83 20:23:45 INFO - PROCESS | 3070 | Values: 327.5 333.1 340.0 341.1 343.0 5448.5 5478.3 5483.9 5516.5 5527.6 5382.8 5386.8 5436.1 5439.8 5447.3 4041.2 4110.9 4261.5 4265.2 4302.2 4223.1 4242.9 4272.7 4274.3 4285.6 4018.6 4226.4 4233.6 4241.4 4258.8 3973.9 4144.7 4210.4 4255.4 4261.4 3770.3 3775.2 3790.8 3796.8 3797.4 5166.5 5306.3 5335.0 5342.9 5351.1 4833.8 4857.7 4865.7 4872.4 4902.6 5546.3 5546.9 5557.2 5618.5 5654.7 3901.5 4047.9 4064.7 4098.1 4111.5 5866.9 5881.6 5894.7 5901.8 5915.5 4173.5 4176.7 4183.5 4188.7 4193.6 4076.3 4209.9 4220.1 4237.6 4242.6 4767.3 4785.5 4793.3 4825.2 4825.4 5683.4 5712.4 5720.2 5729.5 5780.3 1370.7 1439.4 1439.7 1444.9 1475.6 924.3 928.2 932.8 937.9 956.2 5357.4 5397.4 5398.9 5483.9 5584.7 5808.3 5837.9 5845.6 5864.4 5868.9 5308.8 5538.9 5547.8 5574.5 5603.1 3088.4 3099.7 3119.3 3134.3 3138.4 5758.8 5998.8 6008.2 6049.0 6090.1 6004.7 6011.7 6016.5 6019.8 6066.5 6042.2 6091.6 6101.8 6119.8 6131.6 5577.4 5884.5 5886.9 5901.3 5963.8 5803.2 5825.2 5830.2 5861.6 5867.7 5796.6 6085.8 6105.2 6116.5 6144.2 4156.7 4167.2 4177.7 4184.9 4204.5 5930.2 5960.6 5969.0 5969.1 5980.6 5715.5 5767.5 5773.3 5818.8 5855.9 5674.8 5739.0 5755.9 5775.6 5790.8 5175.6 5412.8 5685.3 5698.9 5753.9 5682.9 5732.2 5740.3 5746.2 5754.0 5640.7 5645.8 5651.4 5667.9 5674.5 20:23:45 INFO - PROCESS | 3070 | 20:23:45 INFO - PROCESS | 3070 | [#5] yui.html Cycles:180 Average:20798.46 Median:4484.20 stddev:29777.39 (664.1%) stddev-sans-first:29822.87 20:23:45 INFO - PROCESS | 3070 | Values: 751.1 783.0 813.6 817.7 850.5 16126.8 16825.2 16848.7 16857.8 16861.2 15209.2 15313.9 15316.5 15319.8 15334.2 662.8 787.9 811.3 814.4 815.9 816.2 818.8 822.4 822.8 823.2 698.7 870.6 871.9 872.3 872.3 817.6 850.9 855.8 856.8 856.8 624.8 628.9 629.5 629.7 629.7 15302.5 15429.0 15485.3 15503.0 15504.6 14305.9 14369.7 14379.6 14515.9 14582.9 12712.9 12820.0 12877.9 12890.4 13260.1 4452.4 4465.7 4471.1 4497.3 4643.6 78833.0 78870.6 79374.2 79410.6 79585.0 11486.7 11669.9 11735.6 11844.2 11929.3 21313.9 21583.7 21665.6 21687.8 21956.7 8639.9 8732.7 8790.6 8792.5 8802.2 4701.5 4710.7 4757.0 4793.7 5010.7 3540.1 3645.2 3646.9 3651.4 3651.5 564.6 617.1 643.4 701.9 705.6 692.8 750.2 760.2 772.5 785.4 10133.4 10161.3 10288.1 10421.5 10880.3 642.6 710.4 741.7 744.8 768.6 4994.8 5042.6 5082.5 5096.9 5100.9 75260.2 75856.6 122608.0 124227.0 129893.0 101484.5 104492.0 104915.5 107914.0 108120.5 55472.7 55545.0 66737.0 88752.0 89437.0 9581.4 9659.8 9742.6 9754.0 9877.6 53166.0 53421.5 55116.0 55585.7 56366.7 79230.0 80103.0 80137.4 81906.0 85530.6 11305.9 12150.2 12647.3 12756.8 12944.5 13952.7 14288.3 14309.1 14406.9 14892.3 13375.5 13412.1 13703.2 13941.4 14389.6 12970.9 13412.0 13528.3 13645.7 14038.1 13292.5 13463.7 13517.9 13799.6 13835.9 10352.1 10398.1 10465.3 10492.9 10647.4 11058.5 11290.5 11441.3 11510.2 11514.0 20:23:45 INFO - PROCESS | 3070 | -------- Summary: end -------- 20:23:45 INFO - PROCESS | 3070 | 20:23:46 INFO - TEST-INFO | 3070: exit 0 20:23:46 INFO - TEST-OK | dromaeo_css | took 1114059ms 20:23:46 INFO - TEST-START | kraken 20:23:46 INFO - operating with platform_type : linux_ 20:23:46 INFO - Initialising browser for kraken test... 20:23:46 INFO - TEST-INFO | started process 3260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeg4COH/profile http://localhost:41902/getInfo.html) 20:23:50 INFO - PROCESS | 3260 | __metrics Screen width/height:1600/1200 20:23:50 INFO - PROCESS | 3260 | colorDepth:24 20:23:50 INFO - PROCESS | 3260 | Browser inner width/height: 1024/697 20:23:50 INFO - PROCESS | 3260 | __metrics 20:23:50 INFO - PROCESS | 3260 | 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" 20:23:50 INFO - PROCESS | 3260 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:51 INFO - TEST-INFO | 3260: exit 0 20:23:51 INFO - Browser initialized. 20:23:51 INFO - Running cycle 1/1 for kraken test... 20:23:51 INFO - TEST-INFO | started process 3343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeg4COH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:24:03 INFO - PROCESS | 3343 | RSS: Main: 157630464 20:24:03 INFO - PROCESS | 3343 | 20:24:06 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41902/tests/kraken/driver.html?testName=audio-beat-detection) 20:24:07 INFO - PROCESS | 3343 | RSS: Main: 216858624 20:24:07 INFO - PROCESS | 3343 | 20:24:09 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41902/tests/kraken/driver.html?testName=audio-dft) 20:24:10 INFO - PROCESS | 3343 | RSS: Main: 205942784 20:24:10 INFO - PROCESS | 3343 | 20:24:13 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41902/tests/kraken/driver.html?testName=audio-fft) 20:24:14 INFO - PROCESS | 3343 | RSS: Main: 270237696 20:24:14 INFO - PROCESS | 3343 | 20:24:16 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41902/tests/kraken/driver.html?testName=audio-oscillator) 20:24:16 INFO - PROCESS | 3343 | RSS: Main: 180776960 20:24:16 INFO - PROCESS | 3343 | 20:24:18 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:24:19 INFO - PROCESS | 3343 | RSS: Main: 185397248 20:24:19 INFO - PROCESS | 3343 | 20:24:22 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41902/tests/kraken/driver.html?testName=imaging-darkroom) 20:24:23 INFO - PROCESS | 3343 | RSS: Main: 219213824 20:24:23 INFO - PROCESS | 3343 | 20:24:26 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41902/tests/kraken/driver.html?testName=imaging-desaturate) 20:24:27 INFO - PROCESS | 3343 | RSS: Main: 221331456 20:24:27 INFO - PROCESS | 3343 | 20:24:29 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41902/tests/kraken/driver.html?testName=json-parse-financial) 20:24:30 INFO - PROCESS | 3343 | RSS: Main: 221437952 20:24:30 INFO - PROCESS | 3343 | 20:24:31 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:24:32 INFO - PROCESS | 3343 | RSS: Main: 209874944 20:24:32 INFO - PROCESS | 3343 | 20:24:34 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:24:34 INFO - PROCESS | 3343 | RSS: Main: 213073920 20:24:34 INFO - PROCESS | 3343 | 20:24:36 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:24:37 INFO - PROCESS | 3343 | RSS: Main: 210300928 20:24:37 INFO - PROCESS | 3343 | 20:24:40 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:24:40 INFO - PROCESS | 3343 | RSS: Main: 223813632 20:24:40 INFO - PROCESS | 3343 | 20:24:43 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:24:43 INFO - PROCESS | 3343 | RSS: Main: 224899072 20:24:43 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | Cycle 1(1): loaded http://localhost:41902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41902/tests/kraken/driver.html?testName=ai-astar) 20:24:45 INFO - PROCESS | 3343 | RSS: Main: 267370496 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | __start_tp_report 20:24:45 INFO - PROCESS | 3343 | _x_x_mozilla_page_load 20:24:45 INFO - PROCESS | 3343 | _x_x_mozilla_page_load_details 20:24:45 INFO - PROCESS | 3343 | |i|pagename|runs| 20:24:45 INFO - PROCESS | 3343 | |0;ai-astar;105;111;111;111;111;112;109;109;110;110 20:24:45 INFO - PROCESS | 3343 | |1;audio-beat-detection;152;115;117;167;116;118;148;116;171;117 20:24:45 INFO - PROCESS | 3343 | |2;audio-dft;160;161;160;159;162;162;161;162;162;161 20:24:45 INFO - PROCESS | 3343 | |3;audio-fft;74;74;78;114;74;75;75;74;102;74 20:24:45 INFO - PROCESS | 3343 | |4;audio-oscillator;84;85;108;84;85;84;117;84;84;120 20:24:45 INFO - PROCESS | 3343 | |5;imaging-gaussian-blur;116;116;116;117;117;117;118;117;117;117 20:24:45 INFO - PROCESS | 3343 | |6;imaging-darkroom;147;147;146;145;145;145;146;146;146;147 20:24:45 INFO - PROCESS | 3343 | |7;imaging-desaturate;95;95;95;94;95;95;97;95;95;94 20:24:45 INFO - PROCESS | 3343 | |8;json-parse-financial;51;50;51;50;50;50;51;51;50;51 20:24:45 INFO - PROCESS | 3343 | |9;json-stringify-tinderbox;63;62;62;62;62;61;62;63;63;62 20:24:45 INFO - PROCESS | 3343 | |10;stanford-crypto-aes;75;74;76;74;75;74;78;74;74;75 20:24:45 INFO - PROCESS | 3343 | |11;stanford-crypto-ccm;121;128;117;126;131;118;124;126;162;128 20:24:45 INFO - PROCESS | 3343 | |12;stanford-crypto-pbkdf2;160;158;153;156;155;154;152;160;162;158 20:24:45 INFO - PROCESS | 3343 | |13;stanford-crypto-sha256-iterative;63;63;69;63;63;61;63;61;64;61 20:24:45 INFO - PROCESS | 3343 | __end_tp_report 20:24:45 INFO - PROCESS | 3343 | __start_cc_report 20:24:45 INFO - PROCESS | 3343 | _x_x_mozilla_cycle_collect,1657 20:24:45 INFO - PROCESS | 3343 | __end_cc_report 20:24:45 INFO - PROCESS | 3343 | __startTimestamp1468898685803__endTimestamp 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | ------- Summary: start ------- 20:24:45 INFO - PROCESS | 3343 | Number of tests: 14 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:1.97 (1.8%) stddev-sans-first:1.01 20:24:45 INFO - PROCESS | 3343 | Values: 105.0 111.0 111.0 111.0 111.0 112.0 109.0 109.0 110.0 110.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:133.00 stddev:23.14 (17.4%) stddev-sans-first:23.58 20:24:45 INFO - PROCESS | 3343 | Values: 152.0 115.0 117.0 167.0 116.0 118.0 148.0 116.0 171.0 117.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 20:24:45 INFO - PROCESS | 3343 | Values: 160.0 161.0 160.0 159.0 162.0 162.0 161.0 162.0 162.0 161.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.00 stddev:14.35 (19.4%) stddev-sans-first:14.97 20:24:45 INFO - PROCESS | 3343 | Values: 74.0 74.0 78.0 114.0 74.0 75.0 75.0 74.0 102.0 74.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:15.13 (18.0%) stddev-sans-first:15.65 20:24:45 INFO - PROCESS | 3343 | Values: 84.0 85.0 108.0 84.0 85.0 84.0 117.0 84.0 84.0 120.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 20:24:45 INFO - PROCESS | 3343 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 20:24:45 INFO - PROCESS | 3343 | Values: 147.0 147.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 147.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 20:24:45 INFO - PROCESS | 3343 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 97.0 95.0 95.0 94.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 20:24:45 INFO - PROCESS | 3343 | Values: 51.0 50.0 51.0 50.0 50.0 50.0 51.0 51.0 50.0 51.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 20:24:45 INFO - PROCESS | 3343 | Values: 63.0 62.0 62.0 62.0 62.0 61.0 62.0 63.0 63.0 62.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:1.29 (1.7%) stddev-sans-first:1.36 20:24:45 INFO - PROCESS | 3343 | Values: 75.0 74.0 76.0 74.0 75.0 74.0 78.0 74.0 74.0 75.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:127.00 stddev:12.73 (10.0%) stddev-sans-first:13.24 20:24:45 INFO - PROCESS | 3343 | Values: 121.0 128.0 117.0 126.0 131.0 118.0 124.0 126.0 162.0 128.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:158.00 stddev:3.33 (2.1%) stddev-sans-first:3.32 20:24:45 INFO - PROCESS | 3343 | Values: 160.0 158.0 153.0 156.0 155.0 154.0 152.0 160.0 162.0 158.0 20:24:45 INFO - PROCESS | 3343 | 20:24:45 INFO - PROCESS | 3343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.33 (3.7%) stddev-sans-first:2.47 20:24:45 INFO - PROCESS | 3343 | Values: 63.0 63.0 69.0 63.0 63.0 61.0 63.0 61.0 64.0 61.0 20:24:45 INFO - PROCESS | 3343 | -------- Summary: end -------- 20:24:45 INFO - PROCESS | 3343 | 20:24:46 INFO - TEST-INFO | 3343: exit 0 20:24:46 INFO - TEST-OK | kraken | took 60659ms 20:24:46 INFO - SUITE-END | took 1174s 20:24:46 INFO - Completed test suite (00:19:34) 20:24:46 INFO - javascript benchmark 20:24:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.083175047486, 3074.6464156621996, 3085.8457077146145, 3102.844857757113, 3108.70467305606, 5315.893682126365, 5373.382061062979, 5399.244105825188, 5510.063289240828, 5524.14375771755, 5462.808801691942, 5494.1758736189595, 5513.09034009388, 5574.386817450078, 5595.468430499106, 4873.951260487394, 4890.021995600876, 4892.461829198785, 4973.5772459341, 4989.925151122718, 4942.9258561121615, 5079.695218286896, 5094.821681241157, 5098.158803797388, 5151.665141765792, 4873.269009648546, 4916.434610019822, 4993.126202914494, 5008.524190201925, 5061.417936937262, 4956.083124621957, 4988.82539111133, 4996.675216110941, 5012.77442515084, 5051.6716413433005, 4934.777934992934, 4949.282354058641, 4962.6526143169995, 4971.627127965381, 5009.398872135367, 5322.5209731124, 5440.863978400532, 5484.643498172606, 5490.835274941758, 5498.670079795185, 5956.344802071769, 5966.31387390447, 5986.5210783137245, 5988.61074030191, 5989.940100598982, 5978.252718410199, 6016.458518733335, 6024.0662697282, 6029.306629737593, 6041.6979151042715, 5369.973150134263, 5392.137258038695, 5459.972700136514, 5462.754176062087, 5600.215969764236, 5977.462028417463, 5982.042873140276, 6032.638041717511, 6044.909326360108, 6045.425684559959, 5804.477597016289, 5813.59304848665, 5815.127730840323, 5817.0401883689565, 5821.825345239649, 5689.061304884731, 5754.510866576305, 5764.106563482667, 5806.216160818235, 5882.529397648178, 5756.740946657411, 5792.739326730307, 5802.709864506842, 5805.187273781674, 5851.38560451155, 5618.6628802272, 5737.5983681141915, 5775.88448231033, 5780.913286300709, 5793.565482588822, 4334.0, 4374.606285434326, 4428.734275943454, 4444.044530425974, 4478.507364190002, 3901.5708272090046, 3902.926695158854, 3904.0869973712674, 3945.861894833667, 3947.6644485219076, 5413.53984911287, 5496.862578435571, 5504.256925315111, 5504.284443022461, 5509.283793106951, 5851.61964472308, 5885.764569417261, 5895.64626122434, 5939.851503712442, 5964.940350596526, 5594.13290939905, 5599.524040456607, 5605.159226116115, 5607.243022192033, 5607.943920560824, 4738.739369334719, 4956.727379994135, 4962.03240368132, 4967.105920934267, 5007.474215207423, 5958.612690175125, 6031.969840150771, 6037.366076561898, 6052.182955300978, 6065.878682426415, 5869.119632055055, 5870.735816888336, 5871.823845284648, 5873.911891321548, 5893.5874488785375, 5848.385919478394, 5986.700664966821, 6034.728437220423, 6056.939430605637, 6057.787977420945, 5771.3651498335985, 5801.796937107181, 5823.18475413451, 5824.126381042877, 5878.970605147118, 5851.180834683063, 5854.590178687451, 5907.881842363215, 5921.467067963904, 5923.614965027259, 5618.7190640467, 5705.429457054262, 5748.9425105748405, 5776.653400795965, 5779.595428319977, 5796.391378905154, 5798.710064496674, 5801.100829371454, 5803.361630220588, 5853.0, 5718.228039214653, 5721.828345149652, 5723.255976723, 5724.79963201286, 5728.885422291614, 5629.324481062299, 5705.657660540381, 5745.913811292918, 5764.19301297827, 5815.534757219328, 5512.476314750093, 5590.720463976703, 5591.245181900392, 5639.238702775073, 5661.377248502744], "value": 5393.179016343499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.2301892445199, 612.7855250662267, 626.4424662050773, 629.1820633176872, 640.1741753138451, 30930.690693093064, 42624.0, 44198.33702494457, 44218.778906105465, 47048.76475617626, 44880.775596122054, 45515.77242113793, 45529.77235113828, 45531.54468455315, 45538.0, 8040.638171282307, 8250.092489826115, 8251.83496330076, 8983.595738191798, 9090.2273306769, 8334.374921880853, 10760.73098172548, 11047.116230701524, 11049.779004419906, 11413.201075924688, 11273.830892536618, 11315.434228288552, 11323.150763692714, 11330.263532870336, 11342.886571134306, 8177.182281771835, 10745.78508429827, 11000.009999100079, 11103.666889993314, 11123.443827808618, 10700.143988480902, 11074.723131921686, 11079.778404431867, 11090.279131856403, 11095.167862410271, 43693.0, 43789.78105109486, 43854.56145438569, 44054.55945440569, 44055.0, 3636.6181550937035, 3921.29416704993, 4227.0489139943575, 4294.162638285536, 4471.195184866723, 32712.345753084806, 33144.66855331464, 33412.665873341444, 33458.1635459113, 34051.14872128192, 4350.586694264071, 4493.865184044484, 4510.413646225969, 4609.953900460986, 4616.0, 251291.99999999817, 251408.0, 252145.0, 252850.0, 253865.0, 57890.0, 57924.420755792744, 58246.708766456744, 58274.41725582775, 58336.0, 61669.0, 61762.38237617656, 61862.381376185665, 61930.380696192464, 61942.38057619456, 16317.102559359111, 16629.251683674265, 16648.417305394254, 16651.750223746654, 16662.08358540292, 11452.656420307405, 11671.782361351316, 12022.879771202352, 12884.291363975071, 12984.480620775252, 16444.095574743264, 16500.504984850475, 16596.17019149062, 16762.664746705, 16832.0, 5964.194833697396, 5980.611260268156, 6036.0, 6072.392760723892, 6191.535634827406, 1015.8069966706303, 1041.9479026048666, 1127.520803658442, 1128.2891778179694, 1165.184370940328, 33327.50008749822, 33613.83193084068, 33716.66283337184, 33780.662193378244, 34322.48516272258, 1132.6375559820779, 1143.3540049871797, 1151.2631915574038, 1208.3595694282044, 1237.3318408059547, 17007.0, 17704.645907082046, 17755.964090632406, 17881.514885465855, 17895.552611184823, 528854.0, 578461.0, 585899.0, 594526.0, 596630.0, 58632.41367586355, 58639.0, 59089.70455147783, 63998.68000659967, 64212.67893660502, 1242.571312897031, 1432.3124900048035, 1438.3096113865404, 1446.6021843992987, 1483.9777403338742, 30977.845110774302, 34831.0, 34862.0, 34975.300493990486, 35037.299254015285, 51446.0, 51926.48073519216, 51986.220206696176, 52048.479515204366, 52227.73886130545, 433540.0, 436750.0, 439754.0, 440450.0, 441369.0, 37574.624253757116, 44595.777021114685, 46011.0, 46302.536974629824, 49494.0, 49373.753131234116, 49938.0, 50321.0, 51085.23372149347, 51403.485965141364, 42160.36759448672, 42808.78595607002, 43254.351184732885, 43726.56273437225, 44567.77716111398, 42496.57503424926, 42823.5717642832, 42930.570694292655, 43385.13229735451, 43472.071516032425, 43611.56388436075, 43800.0, 43816.342754858066, 43934.340984885894, 44083.33874991813, 36234.456483152244, 37962.43056354212, 38516.6148338513, 39141.0, 39145.0, 29135.417291654474, 29383.7061629381, 29559.85220073886, 29812.0, 29926.102216933527], "value": 21033.483097871103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.45738024976174, 403.1292408397861, 405.98782036538915, 407.78998815609947, 415.36656598687, 18842.717359239607, 20364.59270814583, 20371.388858334274, 20398.388048358553, 21500.354989350304, 19857.900710496462, 20442.488937776525, 20444.795552044514, 20450.284240051602, 20455.693164602504, 5508.256385387981, 5808.12878068289, 5817.650940943557, 5825.0, 5828.737706803183, 5502.724863756816, 5570.275864137677, 5660.688662123582, 5663.2637757091525, 5667.943320566783, 5760.934227167966, 5762.366139724627, 5778.335491418498, 5785.016547186989, 5798.217240672498, 5548.361938377098, 5724.513416359614, 5776.682282474483, 5781.913271300934, 5782.24830771999, 5055.165897626887, 5075.3402057732255, 5089.160288552384, 5094.5160209780015, 5094.7197904115255, 22459.0, 23455.882720586458, 23486.64770028451, 23669.0, 24190.0, 2320.4314942839114, 2335.089315167086, 2336.7780060894356, 2876.3528206153655, 3000.9549856752164, 10370.844437333446, 10718.517666705016, 10730.678079657622, 11867.287962722265, 12600.991920646326, 1948.2012374926353, 1970.7635083790037, 1982.5241941933975, 2013.8489613279062, 2086.8539202255847, 83443.0, 87444.99999999936, 87557.0, 88418.0, 88538.0, 10563.0, 10934.56261749537, 10996.175286853519, 11008.284461509977, 11149.721256968478, 14741.189234591986, 14750.262486875614, 14822.62943426423, 14846.18345990981, 14855.0, 7681.654325555363, 8128.268455839003, 8192.467489613156, 8228.753137405887, 8264.876026859602, 7805.102413222438, 7826.726064587712, 7892.84214315722, 8055.959720201361, 8064.153263907323, 4585.335126406719, 4594.977025114853, 4610.654200934943, 4659.324397962277, 4724.244120940633, 1750.7282231355452, 1938.8158124978104, 2009.1762377425478, 2029.0159272752999, 2072.616565935307, 934.8644446555212, 1012.4380968562518, 1048.397171626318, 1117.9552817887193, 1145.181195445244, 19707.408777736404, 20713.0, 20844.270450534463, 20948.695643479205, 21022.2642207522, 1013.9758843567902, 1032.8052887613821, 1041.9322744021615, 1044.2429238801808, 1092.5356723392686, 10139.875743136328, 11601.361925094032, 11681.182317237712, 11707.648770536898, 11726.530938762355, 508664.0, 520485.0, 522834.0, 525738.0, 526003.0, 92915.0, 93216.53391732997, 95703.0, 96197.51901240449, 97863.51068244613, 998.1036031540132, 1007.315025782475, 1015.0661391519819, 1020.7652239984845, 1030.0935177044303, 17910.731339030186, 18273.543161420537, 18356.265749369875, 18680.0, 18927.432177034712, 41025.79487102665, 46097.53902460932, 46099.77301588857, 46753.53246467628, 46847.0, 59983.40016599778, 60069.69965150321, 61194.38805611887, 62034.0, 62581.68709156425, 8817.691380801642, 8967.730968070968, 8998.460092394478, 9069.546522673973, 9079.137481939206, 10325.896741032493, 12625.179363341353, 13489.392977315849, 14211.431542738175, 14327.713445730818, 11869.762604747684, 11909.22590031645, 12155.635330940086, 12156.878431215575, 12316.50733970667, 10078.798424031625, 10151.593936242763, 11215.878412159045, 11762.882371176178, 11824.70438239051, 12260.75478490443, 12343.259404435763, 12430.316332601793, 12506.999440044956, 12702.682432939251, 8753.08092650288, 9056.0, 9063.773405664911, 9207.125323094295, 9296.07039296092, 11605.419729013347, 11855.347955862166, 11996.700082497659, 11997.940010299893, 12001.339926304137], "value": 9471.643865918111, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.7370673278808, 1493.9178345191015, 1628.3079691131265, 1735.4706814421613, 1789.5078853315329, 8772.16664416881, 9244.67643632473, 9345.345825792198, 9349.626014959393, 9353.298502612306, 7980.600969951493, 8222.34221262299, 8231.711890083849, 8319.084900660922, 9140.765996590459, 2280.703508543891, 2380.2264264114146, 2388.5461762265113, 2403.0, 2407.7351491336026, 2343.261872510154, 2365.6215005599106, 2369.5024044950583, 2376.346504711201, 2391.0674836813655, 2093.3510611710344, 2300.7584203658625, 2312.433453803812, 2320.3155069254612, 2320.5938960681815, 2352.364861487406, 2370.2178281167176, 2382.5115851250453, 2383.940401489959, 2387.6657267982496, 2203.3610253026764, 2204.922827701023, 2216.445888527868, 2223.7442694090223, 2239.876806775627, 9232.492212928286, 9370.062993700643, 9370.437773733598, 9379.108984646447, 9388.436693798325, 5385.973070134663, 5476.0, 5476.096444086721, 5484.0, 5486.753096110685, 3545.840437180307, 3597.3165098631175, 3682.3371793077235, 3685.3919103347916, 3695.8521659133603, 1222.0, 1250.7123361626786, 1252.7431876465303, 1279.7952327627536, 1293.230527835936, 13008.739825203444, 13046.869531304661, 13058.21650700961, 13067.150635208682, 13089.41097650608, 4779.832705855348, 4786.497417771084, 4888.560029597354, 4971.577415919615, 5000.749962501933, 10977.066949309397, 11001.22991390595, 11005.834912476319, 11007.504662290215, 11027.779444411068, 5549.112142057252, 5561.972190139023, 5570.220169176318, 5570.442955704397, 5578.107502799533, 5002.374703162105, 5026.145555255615, 5040.8487745366965, 5132.6150538709, 5142.9742851286255, 4064.9187016260103, 4129.846349812894, 4137.565555616678, 4164.104717485755, 4179.1432756284885, 1305.5104335874048, 1308.1228437192658, 1318.637374721959, 1321.1610627251764, 1336.4052996416697, 920.3097676742309, 997.7904640025531, 1005.2812239248826, 1019.2814066083394, 1037.865077539915, 6440.77457289002, 6497.285298617148, 6525.641089740015, 6638.402543771083, 6688.063671086052, 951.7573018880141, 994.418265314799, 1000.7648202672366, 1007.6070332570304, 1031.159604921986, 4419.734815911055, 4534.36518887356, 4575.565321294472, 4576.610988065985, 4605.286180642006, 11436.199466037464, 11603.245789023686, 11645.359505227125, 11682.883171168349, 11703.88296117045, 10864.076553493042, 11437.0, 11439.313641181556, 11606.129540284512, 11613.825792613117, 8502.532360720219, 8563.400561960603, 8655.350848686374, 8663.566821659018, 8699.478031318142, 6364.77723279683, 6437.098806167234, 6552.6068435894, 6585.209774827052, 6648.069270302259, 9921.503924803876, 10497.317674351143, 10599.258051936291, 10662.520186591466, 10680.092192163753, 9460.479673617741, 10325.845112323172, 10412.062914337746, 10716.624918127829, 10739.516721747696, 7935.2064793520185, 8266.586670666564, 8354.582270886553, 8375.162483751576, 8386.951631046119, 9068.90931090707, 9164.862527061967, 9174.67888623895, 9175.22010629104, 9183.586738596645, 8016.599170041592, 8285.50286982783, 8321.16788321163, 8432.19894110083, 8436.24073833358, 8110.918890811253, 8116.59417029158, 8182.099969003286, 8308.5430301334, 8356.289715374262, 7267.127944646676, 7469.775906722807, 7523.510971786816, 7561.962190189014, 7563.9621801890635, 5175.534201921845, 5266.868328291824, 5322.973385133049, 5340.385855626652, 5401.8919621606565, 5508.476694713996, 5680.914786278292, 5752.626079304831, 5787.94212057874, 5824.068149096124], "value": 4876.570060307709, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.4809427058113, 333.13717471748174, 339.9541061956636, 341.05357632569616, 342.9657034296572, 5448.536874365679, 5478.315210598676, 5483.890322193553, 5516.531094856932, 5527.613067085305, 5382.784688612451, 5386.761044959661, 5436.130219164935, 5439.755211015504, 5447.319085114361, 4041.151358214771, 4110.856120035799, 4261.4673165854265, 4265.208612382791, 4302.247106756321, 4223.0920352124285, 4242.936355954663, 4272.700910936236, 4274.316109422493, 4285.614294713475, 4018.598140185987, 4226.408302837605, 4233.640140588038, 4241.384999175118, 4258.808353624095, 3973.9403908941244, 4144.720403777925, 4210.421092090466, 4255.446791917062, 4261.382099595541, 3770.264798364293, 3775.1505911170043, 3790.8104594770152, 3796.8101594920417, 3797.39241721326, 5166.535011848951, 5306.283651707009, 5335.0, 5342.877995620925, 5351.143816989302, 4833.839878429187, 4857.73282469464, 4865.732384718839, 4872.4153101628035, 4902.632302577321, 5546.27898373213, 5546.944530554683, 5557.166425036236, 5618.522425593829, 5654.688992105433, 3901.453796468497, 4047.9392809107885, 4064.7357921734992, 4098.118904435561, 4111.527174374955, 5866.853328666774, 5881.558883083786, 5894.705264736746, 5901.822945311647, 5915.5267578593175, 4173.5409104998425, 4176.7076304658385, 4183.477065366829, 4188.748675079444, 4193.559676234013, 4076.286649836267, 4209.852655157116, 4220.092680073799, 4237.63980061692, 4242.596953289494, 4767.3314339980725, 4785.545373189541, 4793.257045158006, 4825.227963525889, 4825.420949486014, 5683.431656834284, 5712.428757124254, 5720.170575266563, 5729.4843464088435, 5780.306363236438, 1370.7327071221016, 1439.3954539093606, 1439.6688761584894, 1444.949426770058, 1475.5720840956217, 924.3390975452584, 928.2481190235795, 932.8041111366554, 937.8733870927474, 956.153803883568, 5357.383900851452, 5397.382269599241, 5398.8920221595345, 5483.862903427446, 5584.664920104726, 5808.303003639506, 5837.854053648608, 5845.620034697731, 5864.44287792659, 5868.853278668067, 5308.787648494017, 5538.86152846174, 5547.750351234205, 5574.470425309589, 5603.103503439512, 3088.366884788613, 3099.729111064453, 3119.3293441909645, 3134.326119884236, 3138.435081685273, 5758.7696492140685, 5998.790042348497, 6008.206184124316, 6048.969755151196, 6090.147379366892, 6004.699765011732, 6011.699415029231, 6016.548758843104, 6019.789307374221, 6066.514678825683, 6042.154098426224, 6091.568481406865, 6101.816945491642, 6119.755209791648, 6131.570790044743, 5577.414371490935, 5884.47039766423, 5886.882262354815, 5901.3213480450295, 5963.7912673056235, 5803.187553742564, 5825.184474173704, 5830.18377427169, 5861.6189947653265, 5867.73595188209, 5796.594238403271, 6085.817425477243, 6105.206323177958, 6116.5106791457465, 6144.201253836973, 4156.667466602604, 4167.229062623424, 4177.665786737114, 4184.8744537663915, 4204.453421055366, 5930.169776231245, 5960.6125601837475, 5968.9856622405405, 5969.074793407029, 5980.611260268069, 5715.457031581993, 5767.519966414482, 5773.278340207474, 5818.76724930998, 5855.94144058571, 5674.829755107354, 5738.987031808334, 5755.942440575708, 5775.624584402, 5790.7973220937065, 5175.645081487839, 5412.83761487156, 5685.260916080883, 5698.886022279614, 5753.935521928456, 5682.9431705684065, 5732.197492350991, 5740.282464691913, 5746.166805813217, 5754.0, 5640.746166422603, 5645.802396916089, 5651.378348381757, 5667.914981275367, 5674.517665998436], "value": 4351.142635150558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.1286907187664, 782.9960850195748, 813.6460639621761, 817.6851912013875, 850.502456063203, 16126.758098628516, 16825.242864071115, 16848.663026739458, 16857.83142168578, 16861.156942152906, 15209.23953802311, 15313.923430382833, 15316.46392376267, 15319.77020344693, 15334.233288335594, 662.7978466567707, 787.9251471110235, 811.2536466450879, 814.3647954595425, 815.9224873636995, 816.1797393619404, 818.8198596308803, 822.4325215601216, 822.7613991942329, 823.185046803663, 698.7344808972583, 870.6169285514385, 871.8910136232971, 872.2585802068223, 872.2934423117264, 817.599376305609, 850.9361797865123, 855.7689423855555, 856.772955166875, 856.8286342731416, 624.8156793745856, 628.8553632664467, 629.4555209743585, 629.672570263465, 629.6757170057424, 15302.464413745465, 15428.997115187589, 15485.303161357766, 15503.0, 15504.612384690361, 14305.928470357685, 14369.71260574793, 14379.640508987255, 14515.854841451555, 14582.854171458363, 12712.872871271262, 12820.0, 12877.871221287762, 12890.355482225945, 13260.138091024053, 4452.443444569429, 4465.709728867613, 4471.0610771737975, 4497.347884556753, 4643.605293550052, 78833.0, 78870.6056469714, 79374.20625793784, 79410.60294698547, 79585.0, 11486.712832179262, 11669.941650291694, 11735.647930562096, 11844.170908036527, 11929.343886086348, 21313.929603453827, 21583.67624485634, 21665.56668866614, 21687.78312216889, 21956.706494025704, 8639.913600864036, 8732.738017859474, 8790.560471976503, 8792.47245165292, 8802.207801297915, 4701.48283688794, 4710.740909250024, 4757.048590281957, 4793.664443488992, 5010.674306170087, 3540.097275194809, 3645.2345007548183, 3646.85412583499, 3651.397519409321, 3651.543557055368, 564.6499170514307, 617.062065660194, 643.3952085040141, 701.8912068629371, 705.5978092487233, 692.8302565871293, 750.2010358967682, 760.1638197982286, 772.5133166105318, 785.3756263770316, 10133.442660653734, 10161.288709790244, 10288.092476340718, 10421.53103110362, 10880.292780969212, 642.5534253693731, 710.4281053751677, 741.6625435426868, 744.8473063022068, 768.5657603454031, 4994.800207991712, 5042.596592272683, 5082.466341034212, 5096.872578185575, 5100.872478188001, 75260.24739752641, 75856.62071689716, 122608.0, 124227.0, 129893.0, 101484.49257753664, 104492.0, 104915.4754226224, 107914.0, 108120.45939770408, 55472.72263638656, 55545.0, 66737.0, 88752.0, 89437.0, 9581.374079191943, 9659.806803863743, 9742.61029558838, 9753.951230244087, 9877.617133601445, 53166.0, 53421.46578534165, 55116.0, 55585.722071389384, 56366.71816640891, 79230.0, 80103.0, 80137.3835139787, 81906.0, 85530.57234713787, 11305.943470282926, 12150.21023633461, 12647.304398258184, 12756.808647870475, 12944.490141827986, 13952.651183720489, 14288.28558572088, 14309.069910455786, 14406.855931440552, 14892.255387230378, 13375.53185638498, 13412.12821166621, 13703.246321452416, 13941.372638231102, 14389.568312950629, 12970.870291297344, 13412.0, 13528.255945922676, 13645.727085458037, 14038.087524310888, 13292.468301268227, 13463.730725385241, 13517.86482135166, 13799.586012419644, 13835.930820345833, 10352.107066040086, 10398.100712232912, 10465.319754215952, 10492.895071049192, 10647.361158330215, 11058.502367393647, 11290.49192786343, 11441.289821444761, 11510.194286399872, 11514.0], "value": 7692.597390979786, "unit": "score"}], "name": "dromaeo_css", "value": 7481.741637430999, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 111.0, 111.0, 111.0, 112.0, 109.0, 109.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 117.0, 167.0, 116.0, 118.0, 148.0, 116.0, 171.0, 117.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 114.0, 74.0, 75.0, 75.0, 74.0, 102.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 108.0, 84.0, 85.0, 84.0, 117.0, 84.0, 84.0, 120.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 97.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 50.0, 50.0, 51.0, 51.0, 50.0, 51.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 63.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 74.0, 75.0, 74.0, 78.0, 74.0, 74.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 117.0, 126.0, 131.0, 118.0, 124.0, 126.0, 162.0, 128.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 153.0, 156.0, 155.0, 154.0, 152.0, 160.0, 162.0, 158.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 69.0, 63.0, 63.0, 61.0, 63.0, 61.0, 64.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1472.8999999999999, "alertThreshold": 2.0}]} 20:24:47 INFO - Return code: 0 20:24:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:24:47 INFO - # TBPL SUCCESS # 20:24:47 INFO - Running post-action listener: _resource_record_post_action 20:24:47 INFO - ##### 20:24:47 INFO - ##### Finished run-tests step (success) 20:24:47 INFO - ##### 20:24:47 INFO - Running post-run listener: _resource_record_post_run 20:24:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565702656; Read time: 12; Write time: 541812 20:24:47 INFO - TinderboxPrint: CPU usage
13.0% 20:24:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:24:47 INFO - TinderboxPrint: I/O write bytes / time
565,702,656 / 541,812 20:24:47 INFO - TinderboxPrint: CPU idle
8,276.1 (87.0%) 20:24:47 INFO - TinderboxPrint: CPU user
1,196.2 (12.6%) 20:24:47 INFO - TinderboxPrint: Swap in / out
0 / 0 20:24:47 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 268734464; Read time: 0; Write time: 308912 20:24:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296353792; Read time: 0; Write time: 232900 20:24:47 INFO - Running post-run listener: _upload_blobber_files 20:24:47 INFO - Blob upload gear active. 20:24:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:24:47 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 20:24:47 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'] 20:24:47 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 20:24:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:24:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:24:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:24:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:48 INFO - (blobuploader) - INFO - Done attempting. 20:24:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:24:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:24:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:49 INFO - (blobuploader) - INFO - Done attempting. 20:24:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:24:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:25:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:00 INFO - (blobuploader) - INFO - Done attempting. 20:25:00 INFO - (blobuploader) - INFO - Iteration through files over. 20:25:00 INFO - Return code: 0 20:25:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:25:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:25:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/750e64907b7e204066ae69bcd00c0a0411975dbb2e006449aa163a3d246c9ff8b223c73214d990a597a506631b7870d3e26018d13b666cc998e7b4cbca445dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1060042e8b0874bbacb51b18563076ec247aa230d3f7183834c427e5ede7c2c3a8a04a81e9eab391d53e7a9fc3b985b9014f53db7709380243124aad41de74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/760a68c6db896f0fad08f7fc1744c62b73c1bab3cfcd5e4201716e36b7f6915b151ada44856a9117e57a7a9cbb602b46ef4becff3e43ad83fbef631a37daf47f"} 20:25:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:25:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:25:00 INFO - Contents: 20:25:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/750e64907b7e204066ae69bcd00c0a0411975dbb2e006449aa163a3d246c9ff8b223c73214d990a597a506631b7870d3e26018d13b666cc998e7b4cbca445dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1060042e8b0874bbacb51b18563076ec247aa230d3f7183834c427e5ede7c2c3a8a04a81e9eab391d53e7a9fc3b985b9014f53db7709380243124aad41de74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/760a68c6db896f0fad08f7fc1744c62b73c1bab3cfcd5e4201716e36b7f6915b151ada44856a9117e57a7a9cbb602b46ef4becff3e43ad83fbef631a37daf47f"} 20:25:00 INFO - Running post-run listener: copy_logs_to_upload_dir 20:25:00 INFO - Copying logs to upload dir... 20:25:00 INFO - mkdir: /builds/slave/test/build/upload/logs 20:25:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.270258 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-18 20:24:59.665764) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:24:59.669353) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907 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/750e64907b7e204066ae69bcd00c0a0411975dbb2e006449aa163a3d246c9ff8b223c73214d990a597a506631b7870d3e26018d13b666cc998e7b4cbca445dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1060042e8b0874bbacb51b18563076ec247aa230d3f7183834c427e5ede7c2c3a8a04a81e9eab391d53e7a9fc3b985b9014f53db7709380243124aad41de74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/760a68c6db896f0fad08f7fc1744c62b73c1bab3cfcd5e4201716e36b7f6915b151ada44856a9117e57a7a9cbb602b46ef4becff3e43ad83fbef631a37daf47f"} build_url:https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/bRVPGa8rQCS5k_m2BKRMbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/750e64907b7e204066ae69bcd00c0a0411975dbb2e006449aa163a3d246c9ff8b223c73214d990a597a506631b7870d3e26018d13b666cc998e7b4cbca445dc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1060042e8b0874bbacb51b18563076ec247aa230d3f7183834c427e5ede7c2c3a8a04a81e9eab391d53e7a9fc3b985b9014f53db7709380243124aad41de74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/760a68c6db896f0fad08f7fc1744c62b73c1bab3cfcd5e4201716e36b7f6915b151ada44856a9117e57a7a9cbb602b46ef4becff3e43ad83fbef631a37daf47f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:24:59.699119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:24:59.699962) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1468896815.151000-109061907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:24:59.780163) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:24:59.780475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:24:59.780783) ========= ========= Total master_lag: 0.17 =========