builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1468898895.82 results: success (0) buildid: 20160718173017 builduid: cb019b03bb964ffdadab5a67dc7e6346 revision: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:15.821577) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:15.822084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:15.822392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:15.837367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:15.837718) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 20:28:16-- 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% 37.9M=0s 2016-07-18 20:28:16 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:15.958421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:15.958799) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016614 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:16.009266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:16.009701) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 20:28:16,270 truncating revision to first 12 chars 2016-07-18 20:28:16,270 Setting DEBUG logging. 2016-07-18 20:28:16,270 attempt 1/10 2016-07-18 20:28:16,270 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:28:16,570 unpacking tar archive at: fx-team-62bb8900cfef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:16.667755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:16.668106) ========= script_repo_revision: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:16.668543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:16.668840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:28:16.679815) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-18 20:28:16.680193) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:28:17 INFO - MultiFileLogger online at 20160718 20:28:17 in /builds/slave/test 20:28:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:28:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:28:17 INFO - {'append_to_log': False, 20:28:17 INFO - 'base_work_dir': '/builds/slave/test', 20:28:17 INFO - 'blob_upload_branch': 'Fx-Team', 20:28:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:28:17 INFO - 'branch': 'Fx-Team', 20:28:17 INFO - 'buildbot_json_path': 'buildprops.json', 20:28:17 INFO - 'config_files': ('talos/linux_config.py',), 20:28:17 INFO - 'default_actions': ('clobber', 20:28:17 INFO - 'read-buildbot-config', 20:28:17 INFO - 'download-and-extract', 20:28:17 INFO - 'populate-webroot', 20:28:17 INFO - 'create-virtualenv', 20:28:17 INFO - 'install', 20:28:17 INFO - 'run-tests'), 20:28:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:28:17 INFO - 'download_minidump_stackwalk': True, 20:28:17 INFO - 'download_symbols': 'ondemand', 20:28:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:28:17 INFO - 'tooltool.py': '/tools/tooltool.py', 20:28:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:28:17 INFO - '/tools/misc-python/virtualenv.py')}, 20:28:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:28:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:28:17 INFO - 'installer_path': 'installer.exe', 20:28:17 INFO - 'log_level': 'info', 20:28:17 INFO - 'log_name': 'talos', 20:28:17 INFO - 'log_to_console': True, 20:28:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:28:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:28:17 INFO - 'opt_config_files': (), 20:28:17 INFO - 'pip_index': False, 20:28:17 INFO - 'sps_profile': False, 20:28:17 INFO - 'sps_profile_interval': 0, 20:28:17 INFO - 'suite': 'dromaeojs-e10s', 20:28:17 INFO - 'system_bits': '32', 20:28:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:28:17 INFO - 'title': 'talos-linux64-ix-060', 20:28:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:28:17 INFO - 'use_talos_json': True, 20:28:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:28:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:28:17 INFO - 'work_dir': 'build'} 20:28:17 INFO - ##### 20:28:17 INFO - ##### Running clobber step. 20:28:17 INFO - ##### 20:28:17 INFO - Running pre-action listener: _resource_record_pre_action 20:28:17 INFO - Running main action method: clobber 20:28:17 INFO - rmtree: /builds/slave/test/build 20:28:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:28:17 INFO - Running post-action listener: _resource_record_post_action 20:28:17 INFO - ##### 20:28:17 INFO - ##### Finished clobber step (success) 20:28:17 INFO - ##### 20:28:17 INFO - ##### 20:28:17 INFO - ##### Running read-buildbot-config step. 20:28:17 INFO - ##### 20:28:17 INFO - Running pre-action listener: _resource_record_pre_action 20:28:17 INFO - Running main action method: read_buildbot_config 20:28:17 INFO - Using buildbot properties: 20:28:17 INFO - { 20:28:17 INFO - "project": "", 20:28:17 INFO - "product": "firefox", 20:28:17 INFO - "script_repo_revision": "production", 20:28:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:28:17 INFO - "repository": "", 20:28:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:28:17 INFO - "buildid": "20160718173017", 20:28:17 INFO - "pgo_build": "True", 20:28:17 INFO - "basedir": "/builds/slave/test", 20:28:17 INFO - "buildnumber": 629, 20:28:17 INFO - "slavename": "talos-linux64-ix-060", 20:28:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:28:17 INFO - "platform": "ubuntu64_hw", 20:28:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:28:17 INFO - "branch": "fx-team", 20:28:17 INFO - "repo_path": "integration/fx-team", 20:28:17 INFO - "revision": "62bb8900cfef139ac0ea2f9bc4db742166d6f9a5", 20:28:17 INFO - "stage_platform": "linux64-pgo", 20:28:17 INFO - "builduid": "cb019b03bb964ffdadab5a67dc7e6346", 20:28:17 INFO - "slavebuilddir": "test" 20:28:17 INFO - } 20:28:17 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:28:17 INFO - Running post-action listener: _resource_record_post_action 20:28:17 INFO - ##### 20:28:17 INFO - ##### Finished read-buildbot-config step (success) 20:28:17 INFO - ##### 20:28:17 INFO - ##### 20:28:17 INFO - ##### Running download-and-extract step. 20:28:17 INFO - ##### 20:28:17 INFO - Running pre-action listener: _resource_record_pre_action 20:28:17 INFO - Running main action method: download_and_extract 20:28:17 INFO - mkdir: /builds/slave/test/build/tests 20:28:17 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:28:17 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:28:17 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:28:17 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:28:17 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:28:17 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:28:18 INFO - Downloaded 1361 bytes. 20:28:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:28:18 INFO - Using the following test package requirements: 20:28:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:28:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:28:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'jsshell-linux-x86_64.zip'], 20:28:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:28:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:28:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:28:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:28:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:28:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:28:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:28:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:18 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:28:18 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:28:18 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:28:18 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:28:18 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:28:19 INFO - Downloaded 24333771 bytes. 20:28:19 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:28:19 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:28:20 INFO - Return code: 0 20:28:20 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:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:20 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:28:20 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:28:20 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:28:20 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:28:20 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:28:21 INFO - Downloaded 24333771 bytes. 20:28:21 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:28:21 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:28:23 INFO - Return code: 0 20:28:23 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:28:23 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:28:23 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:28:23 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:28:23 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:28:23 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:28:24 INFO - Downloaded 14403317 bytes. 20:28:24 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:28:24 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:28:24 INFO - Return code: 0 20:28: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:28:24 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:28: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.tar.bz2 20:28: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.tar.bz2 20:28: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.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:28:24 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:28:25 INFO - Downloaded 60845246 bytes. 20:28:25 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:28:25 INFO - mkdir: /builds/slave/test/properties 20:28:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:28:25 INFO - Writing to file /builds/slave/test/properties/build_url 20:28:25 INFO - Contents: 20:28:25 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:28:26 INFO - Running post-action listener: _resource_record_post_action 20:28:26 INFO - Running post-action listener: set_extra_try_arguments 20:28:26 INFO - ##### 20:28:26 INFO - ##### Finished download-and-extract step (success) 20:28:26 INFO - ##### 20:28:26 INFO - ##### 20:28:26 INFO - ##### Running populate-webroot step. 20:28:26 INFO - ##### 20:28:26 INFO - Running pre-action listener: _resource_record_pre_action 20:28:26 INFO - Running main action method: populate_webroot 20:28:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:28:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:28:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:28:26 INFO - '--tppagecycles', 20:28:26 INFO - '7'], 20:28:26 INFO - 'tests': ['tsvgm']}}, 20:28:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:28:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:28:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:28:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:28:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['damp', 'tps']}, 20:28:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'tests': ['damp', 'tps']}, 20:28:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['dromaeo_dom']}, 20:28:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:28:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['basic_compositor_video']}, 20:28:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:28:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['a11yr', 20:28:26 INFO - 'ts_paint', 20:28:26 INFO - 'tpaint', 20:28:26 INFO - 'sessionrestore', 20:28:26 INFO - 'sessionrestore_no_auto_restore', 20:28:26 INFO - 'tabpaint']}, 20:28:26 INFO - 'other-e10s': {'tests': ['a11yr', 20:28:26 INFO - 'ts_paint', 20:28:26 INFO - 'tpaint', 20:28:26 INFO - 'sessionrestore', 20:28:26 INFO - 'sessionrestore_no_auto_restore', 20:28:26 INFO - 'tabpaint']}, 20:28:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:28:26 INFO - 'ts_paint', 20:28:26 INFO - 'tpaint', 20:28:26 INFO - 'sessionrestore', 20:28:26 INFO - 'sessionrestore_no_auto_restore', 20:28:26 INFO - 'tabpaint']}, 20:28:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:28:26 INFO - 'ts_paint', 20:28:26 INFO - 'tpaint', 20:28:26 INFO - 'sessionrestore', 20:28:26 INFO - 'sessionrestore_no_auto_restore', 20:28:26 INFO - 'tabpaint']}, 20:28:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['a11yr', 20:28:26 INFO - 'ts_paint', 20:28:26 INFO - 'tpaint', 20:28:26 INFO - 'sessionrestore', 20:28:26 INFO - 'sessionrestore_no_auto_restore', 20:28:26 INFO - 'tabpaint']}, 20:28:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['a11yr', 20:28:26 INFO - 'ts_paint', 20:28:26 INFO - 'tpaint', 20:28:26 INFO - 'sessionrestore', 20:28:26 INFO - 'sessionrestore_no_auto_restore', 20:28:26 INFO - 'tabpaint']}, 20:28:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['tsvgx', 20:28:26 INFO - 'tsvgr_opacity', 20:28:26 INFO - 'tart', 20:28:26 INFO - 'tscrollx', 20:28:26 INFO - 'cart']}, 20:28:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:28:26 INFO - 'tsvgr_opacity', 20:28:26 INFO - 'tart', 20:28:26 INFO - 'tscrollx', 20:28:26 INFO - 'cart']}, 20:28:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'talos_options': ['--disable-e10s'], 20:28:26 INFO - 'tests': ['tp5o']}, 20:28:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'tests': ['tp5o']}, 20:28:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'talos_options': ['--disable-e10s', 20:28:26 INFO - '--xperf_path', 20:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:26 INFO - 'tests': ['tp5n']}, 20:28:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:26 INFO - 'talos_options': ['--xperf_path', 20:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:26 INFO - 'tests': ['tp5n']}}, 20:28:26 INFO - 'talos.zip': {'path': '', 20:28:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:26 INFO - Running post-action listener: _resource_record_post_action 20:28:26 INFO - ##### 20:28:26 INFO - ##### Finished populate-webroot step (success) 20:28:26 INFO - ##### 20:28:26 INFO - ##### 20:28:26 INFO - ##### Running create-virtualenv step. 20:28:26 INFO - ##### 20:28:26 INFO - Running pre-action listener: _resource_record_pre_action 20:28:26 INFO - Running main action method: create_virtualenv 20:28:26 INFO - Creating virtualenv /builds/slave/test/build/venv 20:28:26 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:28:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:28:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:28:26 INFO - Using real prefix '/usr' 20:28:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:28:27 INFO - Installing distribute.............................................................................................................................................................................................done. 20:28:29 INFO - Installing pip.................done. 20:28:29 INFO - Return code: 0 20:28:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:28:29 INFO - Using env: {'DISPLAY': ':0', 20:28:29 INFO - 'HOME': '/home/cltbld', 20:28:29 INFO - 'LANG': 'en_US.UTF-8', 20:28:29 INFO - 'LANGUAGE': 'en_US:en', 20:28:29 INFO - 'LOGNAME': 'cltbld', 20:28:29 INFO - 'MAIL': '/var/mail/cltbld', 20:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:29 INFO - 'MOZ_NO_REMOTE': '1', 20:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:29 INFO - 'NO_EM_RESTART': '1', 20:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:29 INFO - 'PWD': '/builds/slave/test', 20:28:29 INFO - 'SHELL': '/bin/bash', 20:28:29 INFO - 'SHLVL': '1', 20:28:29 INFO - 'TERM': 'linux', 20:28:29 INFO - 'TMOUT': '86400', 20:28:29 INFO - 'USER': 'cltbld', 20:28:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:29 INFO - '_': '/tools/buildbot/bin/python'} 20:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:29 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:28:29 INFO - Cleaning up... 20:28:29 INFO - Return code: 0 20:28:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:28:29 INFO - Using env: {'DISPLAY': ':0', 20:28:29 INFO - 'HOME': '/home/cltbld', 20:28:29 INFO - 'LANG': 'en_US.UTF-8', 20:28:29 INFO - 'LANGUAGE': 'en_US:en', 20:28:29 INFO - 'LOGNAME': 'cltbld', 20:28:29 INFO - 'MAIL': '/var/mail/cltbld', 20:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:29 INFO - 'MOZ_NO_REMOTE': '1', 20:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:29 INFO - 'NO_EM_RESTART': '1', 20:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:29 INFO - 'PWD': '/builds/slave/test', 20:28:29 INFO - 'SHELL': '/bin/bash', 20:28:29 INFO - 'SHLVL': '1', 20:28:29 INFO - 'TERM': 'linux', 20:28:29 INFO - 'TMOUT': '86400', 20:28:29 INFO - 'USER': 'cltbld', 20:28:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:29 INFO - '_': '/tools/buildbot/bin/python'} 20:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:29 INFO - Downloading/unpacking psutil>=3.1.1 20:28:29 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:28:29 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:28:29 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:28:29 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:28:29 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:28:29 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:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:31 INFO - Installing collected packages: psutil 20:28:31 INFO - Running setup.py install for psutil 20:28:31 INFO - building 'psutil._psutil_linux' extension 20:28:31 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:28:31 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:28:31 INFO - building 'psutil._psutil_posix' extension 20:28:31 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:28:31 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:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:31 INFO - Successfully installed psutil 20:28:31 INFO - Cleaning up... 20:28:32 INFO - Return code: 0 20:28:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:28:32 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:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:32 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:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:32 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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:32 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:28:32 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:28:32 INFO - Using env: {'DISPLAY': ':0', 20:28:32 INFO - 'HOME': '/home/cltbld', 20:28:32 INFO - 'LANG': 'en_US.UTF-8', 20:28:32 INFO - 'LANGUAGE': 'en_US:en', 20:28:32 INFO - 'LOGNAME': 'cltbld', 20:28:32 INFO - 'MAIL': '/var/mail/cltbld', 20:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:32 INFO - 'MOZ_NO_REMOTE': '1', 20:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:32 INFO - 'NO_EM_RESTART': '1', 20:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:32 INFO - 'PWD': '/builds/slave/test', 20:28:32 INFO - 'SHELL': '/bin/bash', 20:28:32 INFO - 'SHLVL': '1', 20:28:32 INFO - 'TERM': 'linux', 20:28:32 INFO - 'TMOUT': '86400', 20:28:32 INFO - 'USER': 'cltbld', 20:28:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:32 INFO - '_': '/tools/buildbot/bin/python'} 20:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:28:32 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:28:32 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:28:32 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:28:32 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:28:32 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:28:32 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:28:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:28:34 INFO - Installing collected packages: mozsystemmonitor 20:28:34 INFO - Running setup.py install for mozsystemmonitor 20:28:34 INFO - Successfully installed mozsystemmonitor 20:28:34 INFO - Cleaning up... 20:28:34 INFO - Return code: 0 20:28:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:34 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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:34 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:28:34 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:28:34 INFO - Using env: {'DISPLAY': ':0', 20:28:34 INFO - 'HOME': '/home/cltbld', 20:28:34 INFO - 'LANG': 'en_US.UTF-8', 20:28:34 INFO - 'LANGUAGE': 'en_US:en', 20:28:34 INFO - 'LOGNAME': 'cltbld', 20:28:34 INFO - 'MAIL': '/var/mail/cltbld', 20:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:34 INFO - 'MOZ_NO_REMOTE': '1', 20:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:34 INFO - 'NO_EM_RESTART': '1', 20:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:34 INFO - 'PWD': '/builds/slave/test', 20:28:34 INFO - 'SHELL': '/bin/bash', 20:28:34 INFO - 'SHLVL': '1', 20:28:34 INFO - 'TERM': 'linux', 20:28:34 INFO - 'TMOUT': '86400', 20:28:34 INFO - 'USER': 'cltbld', 20:28:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:34 INFO - '_': '/tools/buildbot/bin/python'} 20:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:28:34 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:28:34 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:28:34 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:28:34 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:28:34 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:28:34 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:28:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:28:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 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:28:36 INFO - Downloading functools32-3.2.3-2.tar.gz 20:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:28:36 INFO - warning: no files found matching '*.txt' 20:28:36 INFO - no previously-included directories found matching 'build' 20:28:36 INFO - no previously-included directories found matching 'dist' 20:28:36 INFO - no previously-included directories found matching '.git*' 20:28:36 INFO - Installing collected packages: jsonschema, functools32 20:28:36 INFO - Running setup.py install for functools32 20:28:36 INFO - warning: no files found matching '*.txt' 20:28:36 INFO - no previously-included directories found matching 'build' 20:28:36 INFO - no previously-included directories found matching 'dist' 20:28:36 INFO - no previously-included directories found matching '.git*' 20:28:36 INFO - Successfully installed jsonschema functools32 20:28:36 INFO - Cleaning up... 20:28:36 INFO - Return code: 0 20:28:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:28:36 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:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:36 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:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:36 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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:36 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:28:36 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:28:36 INFO - Using env: {'DISPLAY': ':0', 20:28:36 INFO - 'HOME': '/home/cltbld', 20:28:36 INFO - 'LANG': 'en_US.UTF-8', 20:28:36 INFO - 'LANGUAGE': 'en_US:en', 20:28:36 INFO - 'LOGNAME': 'cltbld', 20:28:36 INFO - 'MAIL': '/var/mail/cltbld', 20:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:36 INFO - 'MOZ_NO_REMOTE': '1', 20:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:36 INFO - 'NO_EM_RESTART': '1', 20:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:36 INFO - 'PWD': '/builds/slave/test', 20:28:36 INFO - 'SHELL': '/bin/bash', 20:28:36 INFO - 'SHLVL': '1', 20:28:36 INFO - 'TERM': 'linux', 20:28:36 INFO - 'TMOUT': '86400', 20:28:36 INFO - 'USER': 'cltbld', 20:28:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:36 INFO - '_': '/tools/buildbot/bin/python'} 20:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:37 INFO - Downloading/unpacking blobuploader==1.2.4 20:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:39 INFO - Downloading blobuploader-1.2.4.tar.gz 20:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:28:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:28:39 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:28:39 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:28:39 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:28:39 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:28:39 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:28:39 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:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:28:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:28:39 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:28:39 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:28:39 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:28:39 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:28:39 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:28:39 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:28:39 INFO - Downloading docopt-0.6.1.tar.gz 20:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:28:39 INFO - Installing collected packages: blobuploader, requests, docopt 20:28:39 INFO - Running setup.py install for blobuploader 20:28:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:28:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:28:40 INFO - Running setup.py install for requests 20:28:40 INFO - Running setup.py install for docopt 20:28:40 INFO - Successfully installed blobuploader requests docopt 20:28:40 INFO - Cleaning up... 20:28:40 INFO - Return code: 0 20:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28: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:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:40 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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:40 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:28:40 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:28:40 INFO - Using env: {'DISPLAY': ':0', 20:28:40 INFO - 'HOME': '/home/cltbld', 20:28:40 INFO - 'LANG': 'en_US.UTF-8', 20:28:40 INFO - 'LANGUAGE': 'en_US:en', 20:28:40 INFO - 'LOGNAME': 'cltbld', 20:28:40 INFO - 'MAIL': '/var/mail/cltbld', 20:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:40 INFO - 'MOZ_NO_REMOTE': '1', 20:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:40 INFO - 'NO_EM_RESTART': '1', 20:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:40 INFO - 'PWD': '/builds/slave/test', 20:28:40 INFO - 'SHELL': '/bin/bash', 20:28:40 INFO - 'SHLVL': '1', 20:28:40 INFO - 'TERM': 'linux', 20:28:40 INFO - 'TMOUT': '86400', 20:28:40 INFO - 'USER': 'cltbld', 20:28:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:40 INFO - '_': '/tools/buildbot/bin/python'} 20:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:40 INFO - Running setup.py (path:/tmp/pip-Fy6_b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:40 INFO - Running setup.py (path:/tmp/pip-JoN7E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:40 INFO - Running setup.py (path:/tmp/pip-YxqhF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:40 INFO - Running setup.py (path:/tmp/pip-zficeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:41 INFO - Running setup.py (path:/tmp/pip-UlQfOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:41 INFO - Running setup.py (path:/tmp/pip-0q3I61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:41 INFO - Running setup.py (path:/tmp/pip-Ifcn_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:41 INFO - Running setup.py (path:/tmp/pip-0EPlrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:41 INFO - Running setup.py (path:/tmp/pip-6IRA6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:41 INFO - Running setup.py (path:/tmp/pip-AD5p9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:41 INFO - Running setup.py (path:/tmp/pip-0vkf4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:41 INFO - Running setup.py (path:/tmp/pip-2HnFyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:41 INFO - Running setup.py (path:/tmp/pip-vBB8TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:41 INFO - Running setup.py (path:/tmp/pip-uC0Yz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:41 INFO - Running setup.py (path:/tmp/pip-d1Zg3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:41 INFO - Running setup.py (path:/tmp/pip-84_OVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:41 INFO - Running setup.py (path:/tmp/pip-z7aOqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:28:41 INFO - Running setup.py install for manifestparser 20:28:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Running setup.py install for mozcrash 20:28:42 INFO - Running setup.py install for mozdebug 20:28:42 INFO - Running setup.py install for mozdevice 20:28:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Running setup.py install for mozfile 20:28:42 INFO - Running setup.py install for mozhttpd 20:28:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Running setup.py install for mozinfo 20:28:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Running setup.py install for mozInstall 20:28:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Running setup.py install for mozleak 20:28:42 INFO - Running setup.py install for mozlog 20:28:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:28:42 INFO - Running setup.py install for moznetwork 20:28:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:28:43 INFO - Running setup.py install for mozprocess 20:28:43 INFO - Running setup.py install for mozprofile 20:28:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:28:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:28:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:28:43 INFO - Running setup.py install for mozrunner 20:28:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:28:43 INFO - Running setup.py install for mozscreenshot 20:28:43 INFO - Running setup.py install for moztest 20:28:43 INFO - Running setup.py install for mozversion 20:28:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:28:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:28:43 INFO - Cleaning up... 20:28:43 INFO - Return code: 0 20:28:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28: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:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:43 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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:43 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:28:43 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:28:43 INFO - Using env: {'DISPLAY': ':0', 20:28:43 INFO - 'HOME': '/home/cltbld', 20:28:43 INFO - 'LANG': 'en_US.UTF-8', 20:28:43 INFO - 'LANGUAGE': 'en_US:en', 20:28:43 INFO - 'LOGNAME': 'cltbld', 20:28:43 INFO - 'MAIL': '/var/mail/cltbld', 20:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:43 INFO - 'MOZ_NO_REMOTE': '1', 20:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:43 INFO - 'NO_EM_RESTART': '1', 20:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:43 INFO - 'PWD': '/builds/slave/test', 20:28:43 INFO - 'SHELL': '/bin/bash', 20:28:43 INFO - 'SHLVL': '1', 20:28:43 INFO - 'TERM': 'linux', 20:28:43 INFO - 'TMOUT': '86400', 20:28:43 INFO - 'USER': 'cltbld', 20:28:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:43 INFO - '_': '/tools/buildbot/bin/python'} 20:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:43 INFO - Running setup.py (path:/tmp/pip-QpwGhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:44 INFO - Running setup.py (path:/tmp/pip-exfClo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:44 INFO - Running setup.py (path:/tmp/pip-437Mlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:44 INFO - Running setup.py (path:/tmp/pip-zcr5rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:44 INFO - Running setup.py (path:/tmp/pip-YyLME2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:44 INFO - Running setup.py (path:/tmp/pip-vaSAs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:44 INFO - Running setup.py (path:/tmp/pip-nUVvkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:44 INFO - Running setup.py (path:/tmp/pip-IADjWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:44 INFO - Running setup.py (path:/tmp/pip-EB0J7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:44 INFO - Running setup.py (path:/tmp/pip-NDm0uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:44 INFO - Running setup.py (path:/tmp/pip-hg0qRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:44 INFO - Running setup.py (path:/tmp/pip-8PwWWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:44 INFO - Running setup.py (path:/tmp/pip-mX2zPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:44 INFO - Running setup.py (path:/tmp/pip-6ppDRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:44 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:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:44 INFO - Running setup.py (path:/tmp/pip-MltAsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:45 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:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:45 INFO - Running setup.py (path:/tmp/pip-qePTTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:45 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:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:45 INFO - Running setup.py (path:/tmp/pip-eBqCyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:45 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:28:45 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:28:45 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:28:45 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:28:45 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:28:45 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:28:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:28: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:28: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:28: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:28: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:28: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:28: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:28:47 INFO - Downloading blessings-1.6.tar.gz 20:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:28:47 INFO - Installing collected packages: blessings 20:28:47 INFO - Running setup.py install for blessings 20:28:47 INFO - Successfully installed blessings 20:28:47 INFO - Cleaning up... 20:28:47 INFO - Return code: 0 20:28:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:28:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:47 INFO - Reading from file tmpfile_stdout 20:28:47 INFO - Current package versions: 20:28:47 INFO - argparse == 1.2.1 20:28:47 INFO - blessings == 1.6 20:28:47 INFO - blobuploader == 1.2.4 20:28:47 INFO - docopt == 0.6.1 20:28:47 INFO - functools32 == 3.2.3-2 20:28:47 INFO - jsonschema == 2.5.1 20:28:47 INFO - manifestparser == 1.1 20:28:47 INFO - mozInstall == 1.12 20:28:47 INFO - mozcrash == 0.17 20:28:47 INFO - mozdebug == 0.1 20:28:47 INFO - mozdevice == 0.48 20:28:47 INFO - mozfile == 1.2 20:28:47 INFO - mozhttpd == 0.7 20:28:47 INFO - mozinfo == 0.9 20:28:47 INFO - mozleak == 0.1 20:28:47 INFO - mozlog == 3.2 20:28:47 INFO - moznetwork == 0.27 20:28:47 INFO - mozprocess == 0.23 20:28:47 INFO - mozprofile == 0.28 20:28:47 INFO - mozrunner == 6.12 20:28:47 INFO - mozscreenshot == 0.1 20:28:47 INFO - mozsystemmonitor == 0.3 20:28:47 INFO - moztest == 0.7 20:28:47 INFO - mozversion == 1.4 20:28:47 INFO - psutil == 3.1.1 20:28:47 INFO - requests == 1.2.3 20:28:47 INFO - wsgiref == 0.1.2 20:28:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:47 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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:47 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:28:47 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:28:47 INFO - Using env: {'DISPLAY': ':0', 20:28:47 INFO - 'HOME': '/home/cltbld', 20:28:47 INFO - 'LANG': 'en_US.UTF-8', 20:28:47 INFO - 'LANGUAGE': 'en_US:en', 20:28:47 INFO - 'LOGNAME': 'cltbld', 20:28:47 INFO - 'MAIL': '/var/mail/cltbld', 20:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:47 INFO - 'MOZ_NO_REMOTE': '1', 20:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:47 INFO - 'NO_EM_RESTART': '1', 20:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:47 INFO - 'PWD': '/builds/slave/test', 20:28:47 INFO - 'SHELL': '/bin/bash', 20:28:47 INFO - 'SHLVL': '1', 20:28:47 INFO - 'TERM': 'linux', 20:28:47 INFO - 'TMOUT': '86400', 20:28:47 INFO - 'USER': 'cltbld', 20:28:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:47 INFO - '_': '/tools/buildbot/bin/python'} 20:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:47 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:28:47 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:28:47 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:28:47 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:28:47 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:28:47 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:28:47 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:28:47 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:28:47 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:28:47 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:28:47 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:28:47 INFO - Cleaning up... 20:28:47 INFO - Return code: 0 20:28:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:47 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 0x203e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, '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': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', '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:28:47 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:28:47 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:28:47 INFO - Using env: {'DISPLAY': ':0', 20:28:47 INFO - 'HOME': '/home/cltbld', 20:28:47 INFO - 'LANG': 'en_US.UTF-8', 20:28:47 INFO - 'LANGUAGE': 'en_US:en', 20:28:47 INFO - 'LOGNAME': 'cltbld', 20:28:47 INFO - 'MAIL': '/var/mail/cltbld', 20:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:47 INFO - 'MOZ_NO_REMOTE': '1', 20:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:47 INFO - 'NO_EM_RESTART': '1', 20:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:47 INFO - 'PWD': '/builds/slave/test', 20:28:47 INFO - 'SHELL': '/bin/bash', 20:28:47 INFO - 'SHLVL': '1', 20:28:47 INFO - 'TERM': 'linux', 20:28:47 INFO - 'TMOUT': '86400', 20:28:47 INFO - 'USER': 'cltbld', 20:28:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:47 INFO - '_': '/tools/buildbot/bin/python'} 20:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:28:47 INFO - Cleaning up... 20:28:48 INFO - Return code: 0 20:28:48 INFO - Running post-action listener: _resource_record_post_action 20:28:48 INFO - Running post-action listener: _start_resource_monitoring 20:28:48 INFO - Starting resource monitoring. 20:28:48 INFO - ##### 20:28:48 INFO - ##### Finished create-virtualenv step (success) 20:28:48 INFO - ##### 20:28:48 INFO - ##### 20:28:48 INFO - ##### Running install step. 20:28:48 INFO - ##### 20:28:48 INFO - Running pre-action listener: _resource_record_pre_action 20:28:48 INFO - Running main action method: install 20:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:48 INFO - Reading from file tmpfile_stdout 20:28:48 INFO - Detecting whether we're running mozinstall >=1.0... 20:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:28:48 INFO - Reading from file tmpfile_stdout 20:28:48 INFO - Output received: 20:28:48 INFO - Usage: mozinstall [options] installer 20:28:48 INFO - Options: 20:28:48 INFO - -h, --help show this help message and exit 20:28:48 INFO - -d DEST, --destination=DEST 20:28:48 INFO - Directory to install application into. [default: 20:28:48 INFO - "/builds/slave/test"] 20:28:48 INFO - --app=APP Application being installed. [default: firefox] 20:28:48 INFO - mkdir: /builds/slave/test/build/application 20:28:48 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:28:48 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:29:05 INFO - Reading from file tmpfile_stdout 20:29:05 INFO - Output received: 20:29:05 INFO - /builds/slave/test/build/application/firefox/firefox 20:29:05 INFO - Running post-action listener: _resource_record_post_action 20:29:05 INFO - ##### 20:29:05 INFO - ##### Finished install step (success) 20:29:05 INFO - ##### 20:29:05 INFO - ##### 20:29:05 INFO - ##### Running run-tests step. 20:29:05 INFO - ##### 20:29:05 INFO - Running pre-action listener: _resource_record_pre_action 20:29:05 INFO - Running main action method: run_tests 20:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:29:05 INFO - Python 2.7.3 20:29:05 INFO - Return code: 0 20:29:05 INFO - grabbing minidump binary from tooltool 20:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:29:05 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 0x22fd3b0>, '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 0x22fe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:29:05 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:29:05 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:29:05 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:29:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:29:05 INFO - Return code: 0 20:29:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:29:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:29:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:29:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:29:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:29:05 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-e10s', '--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-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:29:05 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-e10s --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-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:29:05 INFO - Using env: {'DISPLAY': ':0', 20:29:05 INFO - 'HOME': '/home/cltbld', 20:29:05 INFO - 'LANG': 'en_US.UTF-8', 20:29:05 INFO - 'LANGUAGE': 'en_US:en', 20:29:05 INFO - 'LOGNAME': 'cltbld', 20:29:05 INFO - 'MAIL': '/var/mail/cltbld', 20:29:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:29:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:05 INFO - 'MOZ_NO_REMOTE': '1', 20:29:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:05 INFO - 'NO_EM_RESTART': '1', 20:29:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:05 INFO - 'PWD': '/builds/slave/test', 20:29:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:29:05 INFO - 'SHELL': '/bin/bash', 20:29:05 INFO - 'SHLVL': '1', 20:29:05 INFO - 'TERM': 'linux', 20:29:05 INFO - 'TMOUT': '86400', 20:29:05 INFO - 'USER': 'cltbld', 20:29:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330', 20:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:05 INFO - '_': '/tools/buildbot/bin/python'} 20:29:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--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-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:29:05 INFO - mozversion application_buildid: 20160718173017 20:29:05 INFO - mozversion application_changeset: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 20:29:05 INFO - mozversion application_display_name: Nightly 20:29:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:29:05 INFO - mozversion application_name: Firefox 20:29:05 INFO - mozversion application_remotingname: firefox 20:29:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:29:05 INFO - mozversion application_vendor: Mozilla 20:29:05 INFO - mozversion application_version: 50.0a1 20:29:05 INFO - mozversion platform_buildid: 20160718173017 20:29:05 INFO - mozversion platform_changeset: 62bb8900cfef139ac0ea2f9bc4db742166d6f9a5 20:29:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:29:05 INFO - mozversion platform_version: 50.0a1 20:29:05 INFO - using testdate: 1468898945 20:29:05 INFO - actual date: 1468898945 20:29:05 INFO - starting webserver on 'localhost:48978' 20:29:05 INFO - SUITE-START | Running 2 tests 20:29:05 INFO - TEST-START | dromaeo_css 20:29:05 INFO - operating with platform_type : linux_ 20:29:05 INFO - Initialising browser for dromaeo_css test... 20:29:05 INFO - TEST-INFO | started process 22297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl15Xpd/profile http://localhost:48978/getInfo.html) 20:29:10 INFO - PROCESS | 22297 | __metrics Screen width/height:1600/1200 20:29:10 INFO - PROCESS | 22297 | colorDepth:24 20:29:10 INFO - PROCESS | 22297 | Browser inner width/height: 1024/697 20:29:10 INFO - PROCESS | 22297 | __metrics 20:29:10 ERROR - PROCESS | 22297 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:29:11 INFO - TEST-INFO | 22297: exit 0 20:29:11 INFO - Browser initialized. 20:29:11 INFO - Running cycle 1/1 for dromaeo_css test... 20:29:11 INFO - TEST-INFO | started process 22420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl15Xpd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:23 INFO - PROCESS | 22420 | RSS: Main: 167501824 20:29:23 INFO - PROCESS | 22420 | 20:30:13 INFO - PROCESS | 22420 | 1468899013222 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:32:21 INFO - PROCESS | 22420 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48978/tests/dromaeo/cssquery-ext.html) 20:32:22 INFO - PROCESS | 22420 | RSS: Main: 173555712 20:32:22 INFO - PROCESS | 22420 | 20:35:24 INFO - PROCESS | 22420 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-ext.html (next: http://localhost:48978/tests/dromaeo/cssquery-jquery.html) 20:35:25 INFO - PROCESS | 22420 | RSS: Main: 168013824 20:35:25 INFO - PROCESS | 22420 | 20:38:26 INFO - PROCESS | 22420 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48978/tests/dromaeo/cssquery-mootools.html) 20:38:27 INFO - PROCESS | 22420 | RSS: Main: 172367872 20:38:27 INFO - PROCESS | 22420 | 20:41:29 INFO - PROCESS | 22420 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48978/tests/dromaeo/cssquery-prototype.html) 20:41:29 INFO - PROCESS | 22420 | RSS: Main: 166899712 20:41:29 INFO - PROCESS | 22420 | 20:44:32 INFO - PROCESS | 22420 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48978/tests/dromaeo/cssquery-yui.html) 20:44:33 INFO - PROCESS | 22420 | RSS: Main: 168574976 20:44:33 INFO - PROCESS | 22420 | 20:47:35 INFO - PROCESS | 22420 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-yui.html (next: http://localhost:48978/tests/dromaeo/cssquery-dojo.html) 20:47:36 INFO - PROCESS | 22420 | RSS: Main: 169709568 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | __start_tp_report 20:47:36 INFO - PROCESS | 22420 | _x_x_mozilla_page_load 20:47:36 INFO - PROCESS | 22420 | _x_x_mozilla_page_load_details 20:47:36 INFO - PROCESS | 22420 | |i|pagename|runs| 20:47:36 INFO - PROCESS | 22420 | |0;dojo.html;3106.8912588059425;3111.5799367085438;3140.81155130692;3145.1350878508406;3165.905022849314;5602.915956260659;5615.157726341051;5636.774529018845;5643.971780141099;5662.490375866171;5416.133418653017;5541.362743284523;5578.804741834037;5608.411116832735;5614.466625670565;5031.3207716958295;5051.7726702298305;5157.045946499891;5206.505381988705;5208.395503829706;22.471758008948083;4984.800607975677;5015.122353588125;5058.595312375001;5169.922451163236;5011.248312753098;5080.390353157608;5080.898382032338;5082.822101226458;5095.0574143783515;5097.337346145015;5105.361829771278;5130.486951304877;5135.614828887811;5149.639525233235;5041.823536176253;5064.873378165538;5070.619703522214;5093.872653183663;5097.133487307166;5566.387697353288;5595.4964053235;5609.242752228438;5638.436156384329;5640.435956404368;5818.563607729395;5912.438318359749;5950.851228719273;5983.88153323937;6011.068284415923;5946.821595352147;6000.909986350208;6004.669743164124;6058.575899687024;6091.51267898567;5595.440455954413;5598.496135347838;5614.494695477386;5618.662880227159;5643.238162848004;5944.64332140073;6099.634021958696;6127.601705889103;6127.724252408563;6144;5933.703314834327;5944.910826337608;5945.910811337833;5958.136070269873;5987.940120598825;6023.6385816851125;6024.638521688713;6037.396260373927;6037.516998640098;6052.092186172022;5722.7424765885635;5880.852978675482;5963.344032156459;5985.730642121115;6020.066889632114;5988.3113441953865;5999.910001349983;6034.034554471264;6044.395560443921;6049.8487537811025;4525.094981003813;4540.137373898949;4571.245744452128;4585.28928016158;4628.583427491542;3944.8422063117155;3969.583193764671;3988.262171498282;4015.1166743316426;4044.5955404459905;5682.943170568242;5686.118651609007;5704;5731.512821410227;5771.94228057714;6083.908741368883;6093.329733729286;6094.75620975156;6106.358832322542;6108.694565271719;5549.0289199389945;5607.327120745536;5612.607117501817;5638.689872057076;5660.349059858169;4869.391326084239;4880.145974454456;4880.511948805162;4881.365422495053;4968.627352948471;6022;6139.048447490646;6144.201253836973;6151.384861513813;6153.1693221415435;5984.491318237911;5996.5502587307;6024.87950240984;6029;6088.056351265561;6169.043798211284;6169.801546186282;6172.722227499684;6209.0996805462055;6262.530310226843;5743.138529220483;5860.560457965585;5944.256967879015;5949.077892926603;5998.9100163496705;5979;6065.302490213506;6071.301800293023;6080.513558915364;6122.051082082285;5805.82582522525;5861.472467477947;5909.734061967136;5929.822105336847;5939.792107276225;5741.2536370273265;5759.107338362561;5841.065429531254;5915.674637894957;5940.376260492759;5840.182374467663;5858.443447872445;5863.413658634103;5873.295204575307;5894.351621321737;5913.852153696192;5926.851828704144;5940.049592065248;5977.671228082497;5991.670458124845;5625.296837895263;5746.5402767779315;5795.130730390307;5806.44838740319;5836.970815146067 20:47:36 INFO - PROCESS | 22420 | |1;ext.html;545.0516290254138;587.239524815364;590.7253127295807;603.4448307557047;638.2149955554664;38812.80593597032;43819.12361752771;43856.3421548677;43930.34104488427;43993.12013759723;43869.561304386945;43997.34003989943;44106.55893441065;44199.33700994487;44559.55440445594;8869.334799890003;8979.23676487496;8988.550572471382;9007.549622518847;9018.86471702925;8880.467171969702;9016.459012459241;9021.233195178385;9023.954880225623;9088.909110908906;9038.638454461814;9130.72607821763;9152.8627070594;9157.496337701425;9161.404508706946;9062.365634405594;9093.227075698573;9094.36339456235;9110.544472776335;9112.043235460247;8948.373613847034;8948.910510894937;8969.192772650427;8977.461352318882;8996.910030899673;32991.6700832991;41633;41951.7902410486;42027.36958945618;42051.579484205075;3325.201951531639;3335.499675048738;3520.507129001942;3606.6573675500786;4000.739951903117;32005.83997080023;32406.513902291485;32663.346733065442;32669;32777.34445311104;4323.6757243206885;4354.063876266586;4416.447944006999;4458;4556.3393307970155;313079;315326;315410;316083;316894;34534.65465345365;34670.47994280088;34763.82618086944;34841.65158348384;34943;35562.64437355593;36514.26971460609;36555.17224138782;36569.26861462756;36620;14011.719765604834;14111.506097286545;14187.929060354632;14227.64430889236;14272.429102835771;11645.359505227125;11699.473523691455;11773.352465614473;11791.174617776673;11810.114241431927;8291.05160287332;8316.750497485085;8349.081601023883;8396.874046889301;8411.200935911078;3241.497567876983;3259.6472463927203;3310.6027276726945;3344.2642618623863;3344.8996530104137;972.7713987212999;992.573193526776;1035.3194393929653;1078.6494389323502;1091.061686949223;31539;33041.3391732164;33617.15957101043;33769.49345759815;33777;1102.6691992402248;1140.589387820384;1144.9942750286361;1172.7009612548916;1220.1458978714936;17303.56741081483;17428.19064290257;17473.563160920825;17507.649847002987;17562.473125806246;578851;580797;582717;583891;585284;43002.35496467556;43529.56470435255;43641.78179109084;43762.78118609387;43814.90462738457;1275.7065874848836;1339.752145853001;1343.726948304382;1351.2635613590617;1369.869862363054;31532;31948.52077218797;32439.83780081179;32649.025473031194;33000.174995625304;51331.486685134165;51823;51997.7400112997;52095.73952130215;52214.47785522096;514485;515787;516617;516930;517012;28039.71960280371;28329.150125496268;28500.85749571239;28671.569926450702;29026.27434314159;48723.75638121787;48868.75565622149;49118.508814911394;49696.75151624363;49772.25341619951;42521.36217956671;43006;43357.56642433661;44482.332765009196;44571.554284458034;42760.358594620484;42828;43786.34320485131;44013.33979990239;44497.77751111224;41955.160896781286;42262.15475690408;42410.5758942419;43293;43299.35050974175;37742;38153.09234538318;38337.23325533418;38525;39118.60881391264;28872.855635722528;28963.855180724804;29118.854405727834;29311.120666380044;29398.55902161512 20:47:36 INFO - PROCESS | 22420 | |2;jquery.html;389.1011762827866;392.4838836929438;395.0676403687298;395.9128991621842;418.95600961899;13902.582922512316;18172.636547269045;19673.50816229595;20168.59662806743;20219.898900505494;19587.118579663915;19784.30754923578;20195.899020504912;20304.289349872757;20345.28791492298;5730.656160630355;5794;5886.20536227608;5888.322842873082;5902.409759024084;5521.116621340586;5765.1928729977835;5796.768129274824;5813.01178799603;5827.796027139051;5772.3361813391575;5844.211031510756;5850.122481627747;5884;5900.498457631106;5886.499647529944;5887.087501437262;5894.322152952423;6084.117802918552;6097.298810636745;5566.248556444869;5725.312962444534;5752.165935939265;5819.592628516006;5823.301203855522;14404.279786010658;14416;14669.119852808866;17543.385981490588;23934.162304319267;2267.2971378872603;2411.385096800305;2520.5463016656995;2529.557327467704;2947.0127507285083;10505.78988420235;10639.521221545048;11748.823767643493;13179.60461186166;15069.849301506954;1879.2483006797254;1904.4477101640507;2008.2669825513728;2014.1339224133617;2020.797920207982;81943.59028204822;85636.14363856344;86381;89207;89393;10483.423411712276;10680.359178449162;11245.943770281096;11254.324740515594;11396.316221026598;15555.377784888704;15573.221338933236;15580.766288505682;15686.76469852953;15691.372345106296;7511.558743408415;7657.238835067966;7661.923380766232;7793.844123117506;7897.407694422826;7207.099112610924;7260.491765576359;7392;7420.777376678709;7432.888506672404;4767.856964291077;4788.1381351356395;4809;4836.419629644465;4890.926636100461;1995.4412764425983;2024.2995883457966;2039.4901274681329;2061.3815855243365;2068.2761033638108;961.9422834629945;1000.2648053680539;1013.8631284776608;1064.760428903506;1083.2471432354596;19548.804511954982;20462.283820066226;20583;20599.176032958512;20689.379318620464;1000.7097941596855;1029.583018877356;1052.4369462337613;1056.039004505896;1091.939943303126;10968.835467467994;11774.94112529449;11900.940495297467;12542;12604.243745375123;413661;421121;425688;585933;612736;98097.50951245341;99239;102124;102225;102292;997.2520609542843;1008.7377281906757;1022.8977102289712;1048.292402628238;1049.0872940541624;18260.908695456437;18271.725924111415;18717.43847684517;18984.047185495805;18999.24003039863;41810;42437.57562424336;43067.353989690804;43326;44452.333215001156;60725.696371519625;61272;61972;62407.37592624197;63274.68362658157;8467.618957147066;8715.825683486422;8763.561821908752;8764.386492945432;8765.123487651184;9374.859377109486;12597.307148106576;12665.176763510712;13488.5279015234;13540.458381664623;5914.408559144051;10732.839007415052;10862.185336099667;11014.50434730423;11056.834147487632;11402.885971140515;11465.656030319104;11519.88480115188;11537.48081336325;11877.881221187678;10461.110805581611;10649.574017039542;10747.301425407324;10968.670939871816;11227.091394463125;8367.246947774485;8367.28878045373;8598.398112132341;8617.181367770052;8886.73339799807;10355.326903751233;10733.624323148651;10952.671419857417;10993.955574220436;11107.500162492546 20:47:36 INFO - PROCESS | 22420 | |3;mootools.html;1498.5354540092571;1521.5359315408803;1694.466243133413;1822.1071674879297;1850.2783914273427;8116.1478044805335;8936.508492032935;8950.910490895105;9502.334836561444;9506.904930950688;8922.91077089229;9158.58786354614;9201.401908875918;9292.488913109777;9309.813803723922;2389.438481956743;2421.104191449166;2422.8667423291713;2425.490646964131;2430.2952143878256;2391.3304274802995;2397.6883005209297;2412.746661600533;2422.2733180046002;2426.6723992260995;2383.7854593086618;2392.617181251;2394.820388470872;2410.6866107406013;2412.1798588479915;2335.8481698689616;2350.717913850349;2364.5034542746043;2365.727941286757;2382.892769825362;2286.22268428735;2307.6884620576175;2313.1788215183537;2318.7797159269844;2323.1520495019195;9274.860877086849;9348.485833279166;9385.624575016991;9413.058694130601;9432.858507122399;5517.227588137664;5628.634138781007;5672.546196304285;5672.716364181774;5673.801416950387;3412.3687117883023;3546.592141903688;3565.5899571549344;3626.4560315952554;3642.7267954903223;1207.3057991654746;1217.7564487102527;1220.8473940757406;1243.9440225189799;1262.072376803049;12777.10560260782;12814.231146131262;12882;12895.935520322431;12953.611391658265;4464.732116072981;4571.314302854598;4695.506971767915;4730.692504987233;4835.903281934342;10222.182225421948;10225.693229203136;10242.948785256027;10255.7436064099;10259.076683098558;5507;5514.448555144534;5517.034518959166;5521.2270282160525;5524.254225679562;4355.499117601516;4980.825671101494;5131.332926719502;5133.820316288912;5139.537441630271;3720.3489389356755;3831.367824308958;3950.4271880577157;3953.1698343347643;3965.980170099189;1144.6721802708819;1176.6528873982024;1178.8526434195726;1183.2545496337252;1184.691980085184;915.8763566918514;1013.7364285285731;1013.9138173255355;1027.8612387327764;1043.212374657129;6338.207724034496;6421.839454013687;6426.196725409324;6442.098106265126;6486.4486518646445;472.0182021395489;482.2982560374717;488.18960525527456;1048.124815778818;1055.145332280855;4461.620762235181;4508.571685689854;4537.342085397665;4545.409096817459;4572.657050721209;10971.561137554569;11145.108391328675;11266.605668801552;11491.42542872853;11666;10955.890441095646;11373.94313028446;11397;11591.24656897299;11679.474423650956;8406.201410865959;8592.226699596942;8669.956650216709;8675.696350627697;8690.08754080825;6254.2807577129215;6558.1802274715665;6563.737450501926;6587.9670601646685;6658.267590564937;9998.350107243006;10361.119304859172;10607;10632.362058276529;10769.623063193065;10165.390076595428;10675.252732308974;10690.786184276427;10697.251192416456;10763.085137763377;7231.204567497676;7992.84014319722;8070.6368213431715;8220.136885627162;8234.835303294021;9179.678711245075;9187.265018798347;9202.171804537356;9205.125513076247;9289.303302252494;8099.514029158269;8316.958415207886;8427.073021967457;8442.577871106543;8508;7867.449278550446;8017.318527925192;8187.959060204661;8208.425410221465;8383.58082095905;7485.363744081596;7494.3629791466155;7623.733169339046;7625.389968802371;7654.961725191339;5353.625246232727;5384.9192262116885;5397.703126327932;5450.073487507213;5546.667199968015;5556.055470569932;5605.607607467601;5607.523360514238;5634.605577609692;5670.943290567042 20:47:36 INFO - PROCESS | 22420 | |4;prototype.html;334.23293541322664;337.23447773554034;344.16368225212733;347.6627671158975;348.4529289016244;5667.8583035424135;5683.5169010634145;5723.6263296808775;5730.713464326788;5793.42065793421;5622.32532096148;5639.68981706006;5669.461401166883;5692.430756924306;5728.22668939693;4184.3305071188615;4197.538270790211;4320.65434765218;4321.373400856874;4338.479382474107;4307.935380969288;4310.956890431087;4328.156009578133;4344.304911214206;4384.561543845622;4319.114581510798;4345.8478953236645;4347.630451411634;4348.499922508904;4348.652107831382;4255.659547236229;4258.87223383299;4293.184294983943;4296.613304802583;4323.2490841209365;3753.568339640949;3759.9436008459893;3775.131719704456;3811.7522361046445;3820.2741479118877;5514.944850551483;5529.447055294479;5533.889322213533;5575.832725018256;5576.414476479952;4828.420589529243;4952.7028378297055;4969.552740253394;4990.201567749143;5011.2483127530795;5785.942140578624;5832.737526811304;5849.444302791228;5875.8248350330105;5894.58737888348;4115.259253334399;4138.91722165558;4139.834406623731;4175.498940127174;4179.373094035888;5991.55063370249;6064.060070689095;6080.543959203033;6082.665453400061;6087.003758080406;4250.787460627018;4256.7445953242905;4258.850940217078;4261.531231564525;4262.360645903139;4286.6999310047995;4306.181825453154;4319.589638984291;4325.167015604721;4326.382538564187;4758.095961767253;4916.8770780730765;4922.163232250526;4949.455559888409;4953.2074868020945;5894.528437724972;5906.586538942319;5927.762889484458;5963.522918166623;5963.970180149158;1496.9027013244104;1517.8937474376687;1529.8699610533229;1531.29560402214;1538.1847620761014;973.3721749471692;973.571628483465;984.5274268351232;988.6935050134481;995.233670074039;5018.698878067327;5035.446100928895;5057.8229761958155;5090.949090509122;5106.412762532282;5268.394134674485;5324.600654950894;5347.25138480613;5349.849782296747;5358.223057656696;4855.975720121447;5012.473690262543;5012.799488020439;5033.647644664911;5083.694978301313;2841.3606938439098;2843.7298456646586;2850.9287267818054;2863.914082577526;2878.769698424121;5405.8107966221;5471.863203419946;5480.945190548123;5529.806456773994;5559.499645031967;5785.334686511021;6277.905831412532;6287.622742635456;6311.589746666452;6311.652859092702;6292.811215663446;6332.68336583169;6351.872962540816;6385.744570217139;6402.679866006681;6004.369541198112;6095.390460954047;6117.204763380732;6134.4172303631085;6145.324014358328;6050.788222412194;6065.2418447694035;6068.939310607014;6094.024956007018;6117.143599896107;6065.332813390612;6302.243730752156;6372.872542549216;6381.8723625528155;6382.138411314413;4264.445622069111;4296.357739989946;4323.113761678911;4327.134573085333;4339.218940590597;5872.3574391524835;5918.73365698536;6029.457348838626;6174.598651087665;6204.100405441276;5906.316699740553;5943.7028148591535;5977.402259774161;6015.308239552332;6059.909101363395;5788.642587299272;5918.733656985532;5931.733072011683;5970.223870896755;6032.276126864805;5833.445822646841;5857.765689372548;5876.796201424466;5880.941190588211;5912.645241285537;5966.373530779206;5991.3409524953095;6016.6690832002905;6043.637381757108;6055.788047418319;5684.289463817023;5844.736986835687;5850.824475265749;5867.501262392744;5900.321463031806 20:47:36 INFO - PROCESS | 22420 | |5;yui.html;775.3332134364446;802.7391097893186;830.617915758751;863.8704194370846;868.7654333330005;16444.671106577876;16930.492085237463;16979.235934382952;17037.65924681507;17114.486565403044;15287.617809554768;15386.69226615467;15405.306761195745;15418.460353887616;15483.69032619347;661.9602823830561;799.3924617290843;800.8358286551272;802.8554860125175;820.9425340226187;804.4449329962337;808.5391326943644;816.338765599863;816.5957850863831;820.0446479850966;872.2585802068255;874.1957399192758;875.5272153037353;876.6274333408307;878.7583414560983;868.1145231863495;868.1708967935606;869.3349587565517;870.7170169694842;874.5802015032788;635.8601107756286;636.0300541673938;636.805774238857;637.0253512126454;638.5849198021277;14602.70794584113;14622.634434139232;14745.336459859333;14766;14769.33537990793;15574.532764017098;15620.218989050501;15819.92090039554;15867.444639437565;15919.522414327588;10872.945635271852;11222;11430.969953478634;11531.884681153166;12156.574519891761;4032.8185231664647;4037.858674946363;4069.1454794492897;4078.12320351123;4127.731697439687;69861.3013869865;81901.18098818995;83907.58046209729;84415.57792211;85101.14898850994;11262.605808796652;11305.152113591514;11331.886681133248;11474.885251147381;11545.422728863523;22112.22607208772;22525;22550.323490294988;22616.886915565316;22636.773632263797;8863.379563430626;8929.419587726778;9161.633534658673;9258.213051890665;9288.628454861864;4665;4709.929351059737;4792.185328494164;4857.417109946829;4926.113299606033;3623.9818800905828;3640.381135207021;3707.5736290326417;3732.104294969188;3744.26986737589;680.4080450008425;681.2234053179379;686.8221000983237;689.0387908867102;700.1772916822713;608.382491770853;616.9850595770023;644.1497223664811;678.5352033856824;742.1687709765098;10033.849492257623;10117.155931917672;10216.235025103088;10512.526936287886;10780.51487683056;678.6267552845915;690.975815846453;735.7932989896574;744.144234130754;750.6275942634178;5124.461931497213;5134.383873935077;5139.326567578998;5150.768215430315;5220.634555581149;66638.66680666566;73678.6316068427;95602.52198738961;117797;121278.3936080314;103023.48488257511;103883;104312.47843760732;104838;106364;79871.60064199643;80332.19667803364;82929.17070829215;91772;94816.52591736997;9542.85685714701;10303.74722212602;10351.948240258751;10528.947355263175;10559.668403694539;38463.615363846;48906.5109348902;49947.250791237435;52697.7365113172;53282.46717532775;52075;53126.468735312155;64912.35087649063;76164.81362981896;82868;12580.685482862635;12588.30764307972;12637.87362126367;12666;12966.80549791735;15459.381624735335;15575.766363504783;15958.281877315316;16033;16090.195490225677;14823.40706371733;14887.330070147085;14990.400383984519;15180.544583662508;15740.842591573937;14262.133701910401;14522.927385363006;14540.709185816437;14800.407983680963;14800.925995369955;14503.85496145025;14693.118412895261;14968.700625987201;15047.247637617857;15374.9231253843;11322.37726924994;11647.184697071123;11702.765944680888;11712.238704484182;12033.157678962389;11239.213255072067;11481.196316258116;11496.137789665641;11754.23597466162;11807.409629518661 20:47:36 INFO - PROCESS | 22420 | __end_tp_report 20:47:36 INFO - PROCESS | 22420 | __start_cc_report 20:47:36 INFO - PROCESS | 22420 | _x_x_mozilla_cycle_collect,372 20:47:36 INFO - PROCESS | 22420 | __end_cc_report 20:47:36 INFO - PROCESS | 22420 | __startTimestamp1468900056038__endTimestamp 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | ------- Summary: start ------- 20:47:36 INFO - PROCESS | 22420 | Number of tests: 6 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | [#0] dojo.html Cycles:165 Average:5529.10 Median:5805.83 stddev:789.75 (13.6%) stddev-sans-first:768.97 20:47:36 INFO - PROCESS | 22420 | Values: 3106.9 3111.6 3140.8 3145.1 3165.9 5602.9 5615.2 5636.8 5644.0 5662.5 5416.1 5541.4 5578.8 5608.4 5614.5 5031.3 5051.8 5157.0 5206.5 5208.4 22.5 4984.8 5015.1 5058.6 5169.9 5011.2 5080.4 5080.9 5082.8 5095.1 5097.3 5105.4 5130.5 5135.6 5149.6 5041.8 5064.9 5070.6 5093.9 5097.1 5566.4 5595.5 5609.2 5638.4 5640.4 5818.6 5912.4 5950.9 5983.9 6011.1 5946.8 6000.9 6004.7 6058.6 6091.5 5595.4 5598.5 5614.5 5618.7 5643.2 5944.6 6099.6 6127.6 6127.7 6144.0 5933.7 5944.9 5945.9 5958.1 5987.9 6023.6 6024.6 6037.4 6037.5 6052.1 5722.7 5880.9 5963.3 5985.7 6020.1 5988.3 5999.9 6034.0 6044.4 6049.8 4525.1 4540.1 4571.2 4585.3 4628.6 3944.8 3969.6 3988.3 4015.1 4044.6 5682.9 5686.1 5704.0 5731.5 5771.9 6083.9 6093.3 6094.8 6106.4 6108.7 5549.0 5607.3 5612.6 5638.7 5660.3 4869.4 4880.1 4880.5 4881.4 4968.6 6022.0 6139.0 6144.2 6151.4 6153.2 5984.5 5996.6 6024.9 6029.0 6088.1 6169.0 6169.8 6172.7 6209.1 6262.5 5743.1 5860.6 5944.3 5949.1 5998.9 5979.0 6065.3 6071.3 6080.5 6122.1 5805.8 5861.5 5909.7 5929.8 5939.8 5741.3 5759.1 5841.1 5915.7 5940.4 5840.2 5858.4 5863.4 5873.3 5894.4 5913.9 5926.9 5940.0 5977.7 5991.7 5625.3 5746.5 5795.1 5806.4 5837.0 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | [#1] ext.html Cycles:180 Average:60912.97 Median:42336.37 stddev:129403.13 (305.7%) stddev-sans-first:129686.76 20:47:36 INFO - PROCESS | 22420 | Values: 545.1 587.2 590.7 603.4 638.2 38812.8 43819.1 43856.3 43930.3 43993.1 43869.6 43997.3 44106.6 44199.3 44559.6 8869.3 8979.2 8988.6 9007.5 9018.9 8880.5 9016.5 9021.2 9024.0 9088.9 9038.6 9130.7 9152.9 9157.5 9161.4 9062.4 9093.2 9094.4 9110.5 9112.0 8948.4 8948.9 8969.2 8977.5 8996.9 32991.7 41633.0 41951.8 42027.4 42051.6 3325.2 3335.5 3520.5 3606.7 4000.7 32005.8 32406.5 32663.3 32669.0 32777.3 4323.7 4354.1 4416.4 4458.0 4556.3 313079.0 315326.0 315410.0 316083.0 316894.0 34534.7 34670.5 34763.8 34841.7 34943.0 35562.6 36514.3 36555.2 36569.3 36620.0 14011.7 14111.5 14187.9 14227.6 14272.4 11645.4 11699.5 11773.4 11791.2 11810.1 8291.1 8316.8 8349.1 8396.9 8411.2 3241.5 3259.6 3310.6 3344.3 3344.9 972.8 992.6 1035.3 1078.6 1091.1 31539.0 33041.3 33617.2 33769.5 33777.0 1102.7 1140.6 1145.0 1172.7 1220.1 17303.6 17428.2 17473.6 17507.6 17562.5 578851.0 580797.0 582717.0 583891.0 585284.0 43002.4 43529.6 43641.8 43762.8 43814.9 1275.7 1339.8 1343.7 1351.3 1369.9 31532.0 31948.5 32439.8 32649.0 33000.2 51331.5 51823.0 51997.7 52095.7 52214.5 514485.0 515787.0 516617.0 516930.0 517012.0 28039.7 28329.2 28500.9 28671.6 29026.3 48723.8 48868.8 49118.5 49696.8 49772.3 42521.4 43006.0 43357.6 44482.3 44571.6 42760.4 42828.0 43786.3 44013.3 44497.8 41955.2 42262.2 42410.6 43293.0 43299.4 37742.0 38153.1 38337.2 38525.0 39118.6 28872.9 28963.9 29118.9 29311.1 29398.6 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | [#2] jquery.html Cycles:180 Average:29476.15 Median:2064.83 stddev:82780.23 (4009.1%) stddev-sans-first:82983.64 20:47:36 INFO - PROCESS | 22420 | Values: 389.1 392.5 395.1 395.9 419.0 13902.6 18172.6 19673.5 20168.6 20219.9 19587.1 19784.3 20195.9 20304.3 20345.3 5730.7 5794.0 5886.2 5888.3 5902.4 5521.1 5765.2 5796.8 5813.0 5827.8 5772.3 5844.2 5850.1 5884.0 5900.5 5886.5 5887.1 5894.3 6084.1 6097.3 5566.2 5725.3 5752.2 5819.6 5823.3 14404.3 14416.0 14669.1 17543.4 23934.2 2267.3 2411.4 2520.5 2529.6 2947.0 10505.8 10639.5 11748.8 13179.6 15069.8 1879.2 1904.4 2008.3 2014.1 2020.8 81943.6 85636.1 86381.0 89207.0 89393.0 10483.4 10680.4 11245.9 11254.3 11396.3 15555.4 15573.2 15580.8 15686.8 15691.4 7511.6 7657.2 7661.9 7793.8 7897.4 7207.1 7260.5 7392.0 7420.8 7432.9 4767.9 4788.1 4809.0 4836.4 4890.9 1995.4 2024.3 2039.5 2061.4 2068.3 961.9 1000.3 1013.9 1064.8 1083.2 19548.8 20462.3 20583.0 20599.2 20689.4 1000.7 1029.6 1052.4 1056.0 1091.9 10968.8 11774.9 11900.9 12542.0 12604.2 413661.0 421121.0 425688.0 585933.0 612736.0 98097.5 99239.0 102124.0 102225.0 102292.0 997.3 1008.7 1022.9 1048.3 1049.1 18260.9 18271.7 18717.4 18984.0 18999.2 41810.0 42437.6 43067.4 43326.0 44452.3 60725.7 61272.0 61972.0 62407.4 63274.7 8467.6 8715.8 8763.6 8764.4 8765.1 9374.9 12597.3 12665.2 13488.5 13540.5 5914.4 10732.8 10862.2 11014.5 11056.8 11402.9 11465.7 11519.9 11537.5 11877.9 10461.1 10649.6 10747.3 10968.7 11227.1 8367.2 8367.3 8598.4 8617.2 8886.7 10355.3 10733.6 10952.7 10994.0 11107.5 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | [#3] mootools.html Cycles:180 Average:6074.41 Median:4558.36 stddev:3459.46 (75.9%) stddev-sans-first:3452.07 20:47:36 INFO - PROCESS | 22420 | Values: 1498.5 1521.5 1694.5 1822.1 1850.3 8116.1 8936.5 8950.9 9502.3 9506.9 8922.9 9158.6 9201.4 9292.5 9309.8 2389.4 2421.1 2422.9 2425.5 2430.3 2391.3 2397.7 2412.7 2422.3 2426.7 2383.8 2392.6 2394.8 2410.7 2412.2 2335.8 2350.7 2364.5 2365.7 2382.9 2286.2 2307.7 2313.2 2318.8 2323.2 9274.9 9348.5 9385.6 9413.1 9432.9 5517.2 5628.6 5672.5 5672.7 5673.8 3412.4 3546.6 3565.6 3626.5 3642.7 1207.3 1217.8 1220.8 1243.9 1262.1 12777.1 12814.2 12882.0 12895.9 12953.6 4464.7 4571.3 4695.5 4730.7 4835.9 10222.2 10225.7 10242.9 10255.7 10259.1 5507.0 5514.4 5517.0 5521.2 5524.3 4355.5 4980.8 5131.3 5133.8 5139.5 3720.3 3831.4 3950.4 3953.2 3966.0 1144.7 1176.7 1178.9 1183.3 1184.7 915.9 1013.7 1013.9 1027.9 1043.2 6338.2 6421.8 6426.2 6442.1 6486.4 472.0 482.3 488.2 1048.1 1055.1 4461.6 4508.6 4537.3 4545.4 4572.7 10971.6 11145.1 11266.6 11491.4 11666.0 10955.9 11373.9 11397.0 11591.2 11679.5 8406.2 8592.2 8670.0 8675.7 8690.1 6254.3 6558.2 6563.7 6588.0 6658.3 9998.4 10361.1 10607.0 10632.4 10769.6 10165.4 10675.3 10690.8 10697.3 10763.1 7231.2 7992.8 8070.6 8220.1 8234.8 9179.7 9187.3 9202.2 9205.1 9289.3 8099.5 8317.0 8427.1 8442.6 8508.0 7867.4 8017.3 8188.0 8208.4 8383.6 7485.4 7494.4 7623.7 7625.4 7655.0 5353.6 5384.9 5397.7 5450.1 5546.7 5556.1 5605.6 5607.5 5634.6 5670.9 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | [#4] prototype.html Cycles:180 Average:4887.62 Median:5531.85 stddev:1465.24 (26.5%) stddev-sans-first:1428.94 20:47:36 INFO - PROCESS | 22420 | Values: 334.2 337.2 344.2 347.7 348.5 5667.9 5683.5 5723.6 5730.7 5793.4 5622.3 5639.7 5669.5 5692.4 5728.2 4184.3 4197.5 4320.7 4321.4 4338.5 4307.9 4311.0 4328.2 4344.3 4384.6 4319.1 4345.8 4347.6 4348.5 4348.7 4255.7 4258.9 4293.2 4296.6 4323.2 3753.6 3759.9 3775.1 3811.8 3820.3 5514.9 5529.4 5533.9 5575.8 5576.4 4828.4 4952.7 4969.6 4990.2 5011.2 5785.9 5832.7 5849.4 5875.8 5894.6 4115.3 4138.9 4139.8 4175.5 4179.4 5991.6 6064.1 6080.5 6082.7 6087.0 4250.8 4256.7 4258.9 4261.5 4262.4 4286.7 4306.2 4319.6 4325.2 4326.4 4758.1 4916.9 4922.2 4949.5 4953.2 5894.5 5906.6 5927.8 5963.5 5964.0 1496.9 1517.9 1529.9 1531.3 1538.2 973.4 973.6 984.5 988.7 995.2 5018.7 5035.4 5057.8 5090.9 5106.4 5268.4 5324.6 5347.3 5349.8 5358.2 4856.0 5012.5 5012.8 5033.6 5083.7 2841.4 2843.7 2850.9 2863.9 2878.8 5405.8 5471.9 5480.9 5529.8 5559.5 5785.3 6277.9 6287.6 6311.6 6311.7 6292.8 6332.7 6351.9 6385.7 6402.7 6004.4 6095.4 6117.2 6134.4 6145.3 6050.8 6065.2 6068.9 6094.0 6117.1 6065.3 6302.2 6372.9 6381.9 6382.1 4264.4 4296.4 4323.1 4327.1 4339.2 5872.4 5918.7 6029.5 6174.6 6204.1 5906.3 5943.7 5977.4 6015.3 6059.9 5788.6 5918.7 5931.7 5970.2 6032.3 5833.4 5857.8 5876.8 5880.9 5912.6 5966.4 5991.3 6016.7 6043.6 6055.8 5684.3 5844.7 5850.8 5867.5 5900.3 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - PROCESS | 22420 | [#5] yui.html Cycles:180 Average:20546.26 Median:21103.94 stddev:28765.43 (136.3%) stddev-sans-first:28807.81 20:47:36 INFO - PROCESS | 22420 | Values: 775.3 802.7 830.6 863.9 868.8 16444.7 16930.5 16979.2 17037.7 17114.5 15287.6 15386.7 15405.3 15418.5 15483.7 662.0 799.4 800.8 802.9 820.9 804.4 808.5 816.3 816.6 820.0 872.3 874.2 875.5 876.6 878.8 868.1 868.2 869.3 870.7 874.6 635.9 636.0 636.8 637.0 638.6 14602.7 14622.6 14745.3 14766.0 14769.3 15574.5 15620.2 15819.9 15867.4 15919.5 10872.9 11222.0 11431.0 11531.9 12156.6 4032.8 4037.9 4069.1 4078.1 4127.7 69861.3 81901.2 83907.6 84415.6 85101.1 11262.6 11305.2 11331.9 11474.9 11545.4 22112.2 22525.0 22550.3 22616.9 22636.8 8863.4 8929.4 9161.6 9258.2 9288.6 4665.0 4709.9 4792.2 4857.4 4926.1 3624.0 3640.4 3707.6 3732.1 3744.3 680.4 681.2 686.8 689.0 700.2 608.4 617.0 644.1 678.5 742.2 10033.8 10117.2 10216.2 10512.5 10780.5 678.6 691.0 735.8 744.1 750.6 5124.5 5134.4 5139.3 5150.8 5220.6 66638.7 73678.6 95602.5 117797.0 121278.4 103023.5 103883.0 104312.5 104838.0 106364.0 79871.6 80332.2 82929.2 91772.0 94816.5 9542.9 10303.7 10351.9 10528.9 10559.7 38463.6 48906.5 49947.3 52697.7 53282.5 52075.0 53126.5 64912.4 76164.8 82868.0 12580.7 12588.3 12637.9 12666.0 12966.8 15459.4 15575.8 15958.3 16033.0 16090.2 14823.4 14887.3 14990.4 15180.5 15740.8 14262.1 14522.9 14540.7 14800.4 14800.9 14503.9 14693.1 14968.7 15047.2 15374.9 11322.4 11647.2 11702.8 11712.2 12033.2 11239.2 11481.2 11496.1 11754.2 11807.4 20:47:36 INFO - PROCESS | 22420 | -------- Summary: end -------- 20:47:36 INFO - PROCESS | 22420 | 20:47:36 INFO - TEST-INFO | 22420: exit 0 20:47:36 INFO - TEST-OK | dromaeo_css | took 1110937ms 20:47:36 INFO - TEST-START | kraken 20:47:36 INFO - operating with platform_type : linux_ 20:47:36 INFO - Initialising browser for kraken test... 20:47:36 INFO - TEST-INFO | started process 22669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZKpL4/profile http://localhost:48978/getInfo.html) 20:47:41 INFO - PROCESS | 22669 | __metrics Screen width/height:1600/1200 20:47:41 INFO - PROCESS | 22669 | colorDepth:24 20:47:41 INFO - PROCESS | 22669 | Browser inner width/height: 1024/697 20:47:41 INFO - PROCESS | 22669 | __metrics 20:47:41 ERROR - PROCESS | 22669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:47:42 INFO - TEST-INFO | 22669: exit 0 20:47:42 INFO - Browser initialized. 20:47:42 INFO - Running cycle 1/1 for kraken test... 20:47:42 INFO - TEST-INFO | started process 22789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZKpL4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:54 INFO - PROCESS | 22789 | RSS: Main: 168169472 20:47:54 INFO - PROCESS | 22789 | 20:47:56 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-beat-detection) 20:47:57 INFO - PROCESS | 22789 | RSS: Main: 173334528 20:47:57 INFO - PROCESS | 22789 | 20:48:00 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-dft) 20:48:01 INFO - PROCESS | 22789 | RSS: Main: 172355584 20:48:01 INFO - PROCESS | 22789 | 20:48:03 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-fft) 20:48:04 INFO - PROCESS | 22789 | RSS: Main: 167469056 20:48:04 INFO - PROCESS | 22789 | 20:48:06 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-oscillator) 20:48:07 INFO - PROCESS | 22789 | RSS: Main: 168439808 20:48:07 INFO - PROCESS | 22789 | 20:48:09 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:48:10 INFO - PROCESS | 22789 | RSS: Main: 168783872 20:48:10 INFO - PROCESS | 22789 | 20:48:13 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-darkroom) 20:48:13 INFO - PROCESS | 22789 | RSS: Main: 168022016 20:48:13 INFO - PROCESS | 22789 | 20:48:17 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-desaturate) 20:48:17 INFO - PROCESS | 22789 | RSS: Main: 166330368 20:48:17 INFO - PROCESS | 22789 | 20:48:20 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48978/tests/kraken/driver.html?testName=json-parse-financial) 20:48:21 INFO - PROCESS | 22789 | RSS: Main: 167972864 20:48:21 INFO - PROCESS | 22789 | 20:48:22 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:48:23 INFO - PROCESS | 22789 | RSS: Main: 168034304 20:48:23 INFO - PROCESS | 22789 | 20:48:25 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:48:25 INFO - PROCESS | 22789 | RSS: Main: 167927808 20:48:25 INFO - PROCESS | 22789 | 20:48:28 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:48:28 INFO - PROCESS | 22789 | RSS: Main: 169349120 20:48:28 INFO - PROCESS | 22789 | 20:48:31 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:48:31 INFO - PROCESS | 22789 | RSS: Main: 168734720 20:48:31 INFO - PROCESS | 22789 | 20:48:34 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:48:35 INFO - PROCESS | 22789 | RSS: Main: 169267200 20:48:35 INFO - PROCESS | 22789 | 20:48:36 INFO - PROCESS | 22789 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48978/tests/kraken/driver.html?testName=ai-astar) 20:48:37 INFO - PROCESS | 22789 | RSS: Main: 169639936 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | __start_tp_report 20:48:37 INFO - PROCESS | 22789 | _x_x_mozilla_page_load 20:48:37 INFO - PROCESS | 22789 | _x_x_mozilla_page_load_details 20:48:37 INFO - PROCESS | 22789 | |i|pagename|runs| 20:48:37 INFO - PROCESS | 22789 | |0;ai-astar;102;112;105;111;112;113;114;112;111;111 20:48:37 INFO - PROCESS | 22789 | |1;audio-beat-detection;143;119;144;170;124;145;147;121;182;117 20:48:37 INFO - PROCESS | 22789 | |2;audio-dft;162;162;162;164;161;164;168;165;161;164 20:48:37 INFO - PROCESS | 22789 | |3;audio-fft;75;76;75;170;76;76;75;76;178;77 20:48:37 INFO - PROCESS | 22789 | |4;audio-oscillator;83;84;152;84;83;84;143;84;84;157 20:48:37 INFO - PROCESS | 22789 | |5;imaging-gaussian-blur;117;117;119;117;118;117;118;118;117;119 20:48:37 INFO - PROCESS | 22789 | |6;imaging-darkroom;147;147;146;146;147;147;147;147;146;147 20:48:37 INFO - PROCESS | 22789 | |7;imaging-desaturate;96;98;96;96;96;96;96;96;96;96 20:48:37 INFO - PROCESS | 22789 | |8;json-parse-financial;51;52;56;52;52;52;52;51;52;53 20:48:37 INFO - PROCESS | 22789 | |9;json-stringify-tinderbox;62;63;63;62;64;63;64;63;63;63 20:48:37 INFO - PROCESS | 22789 | |10;stanford-crypto-aes;75;76;75;76;76;79;76;75;87;78 20:48:37 INFO - PROCESS | 22789 | |11;stanford-crypto-ccm;127;137;122;121;123;124;129;130;150;123 20:48:37 INFO - PROCESS | 22789 | |12;stanford-crypto-pbkdf2;157;158;157;159;163;154;159;156;156;162 20:48:37 INFO - PROCESS | 22789 | |13;stanford-crypto-sha256-iterative;63;71;72;63;65;67;63;64;63;63 20:48:37 INFO - PROCESS | 22789 | __end_tp_report 20:48:37 INFO - PROCESS | 22789 | __start_cc_report 20:48:37 INFO - PROCESS | 22789 | _x_x_mozilla_cycle_collect,897 20:48:37 INFO - PROCESS | 22789 | __end_cc_report 20:48:37 INFO - PROCESS | 22789 | __startTimestamp1468900117164__endTimestamp 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | ------- Summary: start ------- 20:48:37 INFO - PROCESS | 22789 | Number of tests: 14 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.77 (3.4%) stddev-sans-first:2.54 20:48:37 INFO - PROCESS | 22789 | Values: 102.0 112.0 105.0 111.0 112.0 113.0 114.0 112.0 111.0 111.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:144.50 stddev:21.95 (15.2%) stddev-sans-first:23.27 20:48:37 INFO - PROCESS | 22789 | Values: 143.0 119.0 144.0 170.0 124.0 145.0 147.0 121.0 182.0 117.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:2.16 (1.3%) stddev-sans-first:2.24 20:48:37 INFO - PROCESS | 22789 | Values: 162.0 162.0 162.0 164.0 161.0 164.0 168.0 165.0 161.0 164.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:41.47 (54.6%) stddev-sans-first:43.33 20:48:37 INFO - PROCESS | 22789 | Values: 75.0 76.0 75.0 170.0 76.0 76.0 75.0 76.0 178.0 77.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:84.00 stddev:32.52 (38.7%) stddev-sans-first:33.61 20:48:37 INFO - PROCESS | 22789 | Values: 83.0 84.0 152.0 84.0 83.0 84.0 143.0 84.0 84.0 157.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 20:48:37 INFO - PROCESS | 22789 | Values: 117.0 117.0 119.0 117.0 118.0 117.0 118.0 118.0 117.0 119.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:48:37 INFO - PROCESS | 22789 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:48:37 INFO - PROCESS | 22789 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.42 (2.7%) stddev-sans-first:1.42 20:48:37 INFO - PROCESS | 22789 | Values: 51.0 52.0 56.0 52.0 52.0 52.0 52.0 51.0 52.0 53.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 20:48:37 INFO - PROCESS | 22789 | Values: 62.0 63.0 63.0 62.0 64.0 63.0 64.0 63.0 63.0 63.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.00 stddev:3.65 (4.8%) stddev-sans-first:3.78 20:48:37 INFO - PROCESS | 22789 | Values: 75.0 76.0 75.0 76.0 76.0 79.0 76.0 75.0 87.0 78.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.00 stddev:8.93 (7.0%) stddev-sans-first:9.46 20:48:37 INFO - PROCESS | 22789 | Values: 127.0 137.0 122.0 121.0 123.0 124.0 129.0 130.0 150.0 123.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.50 stddev:2.77 (1.7%) stddev-sans-first:2.91 20:48:37 INFO - PROCESS | 22789 | Values: 157.0 158.0 157.0 159.0 163.0 154.0 159.0 156.0 156.0 162.0 20:48:37 INFO - PROCESS | 22789 | 20:48:37 INFO - PROCESS | 22789 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:64.50 stddev:3.47 (5.4%) stddev-sans-first:3.57 20:48:37 INFO - PROCESS | 22789 | Values: 63.0 71.0 72.0 63.0 65.0 67.0 63.0 64.0 63.0 63.0 20:48:37 INFO - PROCESS | 22789 | -------- Summary: end -------- 20:48:37 INFO - PROCESS | 22789 | 20:48:38 INFO - TEST-INFO | 22789: exit 0 20:48:38 INFO - TEST-OK | kraken | took 61323ms 20:48:38 INFO - SUITE-END | took 1172s 20:48:38 INFO - Completed test suite (00:19:32) 20:48:38 INFO - javascript benchmark 20:48:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7344.626861513025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.8912588059425, 3111.5799367085438, 3140.81155130692, 3145.1350878508406, 3165.905022849314, 5602.915956260659, 5615.157726341051, 5636.774529018845, 5643.971780141099, 5662.490375866171, 5416.133418653017, 5541.362743284523, 5578.804741834037, 5608.411116832735, 5614.466625670565, 5031.3207716958295, 5051.7726702298305, 5157.045946499891, 5206.505381988705, 5208.395503829706, 22.471758008948083, 4984.800607975677, 5015.122353588125, 5058.595312375001, 5169.922451163236, 5011.248312753098, 5080.390353157608, 5080.898382032338, 5082.822101226458, 5095.0574143783515, 5097.337346145015, 5105.361829771278, 5130.486951304877, 5135.614828887811, 5149.639525233235, 5041.823536176253, 5064.873378165538, 5070.619703522214, 5093.872653183663, 5097.133487307166, 5566.387697353288, 5595.4964053235, 5609.242752228438, 5638.436156384329, 5640.435956404368, 5818.563607729395, 5912.438318359749, 5950.851228719273, 5983.88153323937, 6011.068284415923, 5946.821595352147, 6000.909986350208, 6004.669743164124, 6058.575899687024, 6091.51267898567, 5595.440455954413, 5598.496135347838, 5614.494695477386, 5618.662880227159, 5643.238162848004, 5944.64332140073, 6099.634021958696, 6127.601705889103, 6127.724252408563, 6144.0, 5933.703314834327, 5944.910826337608, 5945.910811337833, 5958.136070269873, 5987.940120598825, 6023.6385816851125, 6024.638521688713, 6037.396260373927, 6037.516998640098, 6052.092186172022, 5722.7424765885635, 5880.852978675482, 5963.344032156459, 5985.730642121115, 6020.066889632114, 5988.3113441953865, 5999.910001349983, 6034.034554471264, 6044.395560443921, 6049.8487537811025, 4525.094981003813, 4540.137373898949, 4571.245744452128, 4585.28928016158, 4628.583427491542, 3944.8422063117155, 3969.583193764671, 3988.262171498282, 4015.1166743316426, 4044.5955404459905, 5682.943170568242, 5686.118651609007, 5704.0, 5731.512821410227, 5771.94228057714, 6083.908741368883, 6093.329733729286, 6094.75620975156, 6106.358832322542, 6108.694565271719, 5549.0289199389945, 5607.327120745536, 5612.607117501817, 5638.689872057076, 5660.349059858169, 4869.391326084239, 4880.145974454456, 4880.511948805162, 4881.365422495053, 4968.627352948471, 6022.0, 6139.048447490646, 6144.201253836973, 6151.384861513813, 6153.1693221415435, 5984.491318237911, 5996.5502587307, 6024.87950240984, 6029.0, 6088.056351265561, 6169.043798211284, 6169.801546186282, 6172.722227499684, 6209.0996805462055, 6262.530310226843, 5743.138529220483, 5860.560457965585, 5944.256967879015, 5949.077892926603, 5998.9100163496705, 5979.0, 6065.302490213506, 6071.301800293023, 6080.513558915364, 6122.051082082285, 5805.82582522525, 5861.472467477947, 5909.734061967136, 5929.822105336847, 5939.792107276225, 5741.2536370273265, 5759.107338362561, 5841.065429531254, 5915.674637894957, 5940.376260492759, 5840.182374467663, 5858.443447872445, 5863.413658634103, 5873.295204575307, 5894.351621321737, 5913.852153696192, 5926.851828704144, 5940.049592065248, 5977.671228082497, 5991.670458124845, 5625.296837895263, 5746.5402767779315, 5795.130730390307, 5806.44838740319, 5836.970815146067], "value": 5475.034714570515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.0516290254138, 587.239524815364, 590.7253127295807, 603.4448307557047, 638.2149955554664, 38812.80593597032, 43819.12361752771, 43856.3421548677, 43930.34104488427, 43993.12013759723, 43869.561304386945, 43997.34003989943, 44106.55893441065, 44199.33700994487, 44559.55440445594, 8869.334799890003, 8979.23676487496, 8988.550572471382, 9007.549622518847, 9018.86471702925, 8880.467171969702, 9016.459012459241, 9021.233195178385, 9023.954880225623, 9088.909110908906, 9038.638454461814, 9130.72607821763, 9152.8627070594, 9157.496337701425, 9161.404508706946, 9062.365634405594, 9093.227075698573, 9094.36339456235, 9110.544472776335, 9112.043235460247, 8948.373613847034, 8948.910510894937, 8969.192772650427, 8977.461352318882, 8996.910030899673, 32991.6700832991, 41633.0, 41951.7902410486, 42027.36958945618, 42051.579484205075, 3325.201951531639, 3335.499675048738, 3520.507129001942, 3606.6573675500786, 4000.739951903117, 32005.83997080023, 32406.513902291485, 32663.346733065442, 32669.0, 32777.34445311104, 4323.6757243206885, 4354.063876266586, 4416.447944006999, 4458.0, 4556.3393307970155, 313079.0, 315326.0, 315410.0, 316083.0, 316894.0, 34534.65465345365, 34670.47994280088, 34763.82618086944, 34841.65158348384, 34943.0, 35562.64437355593, 36514.26971460609, 36555.17224138782, 36569.26861462756, 36620.0, 14011.719765604834, 14111.506097286545, 14187.929060354632, 14227.64430889236, 14272.429102835771, 11645.359505227125, 11699.473523691455, 11773.352465614473, 11791.174617776673, 11810.114241431927, 8291.05160287332, 8316.750497485085, 8349.081601023883, 8396.874046889301, 8411.200935911078, 3241.497567876983, 3259.6472463927203, 3310.6027276726945, 3344.2642618623863, 3344.8996530104137, 972.7713987212999, 992.573193526776, 1035.3194393929653, 1078.6494389323502, 1091.061686949223, 31539.0, 33041.3391732164, 33617.15957101043, 33769.49345759815, 33777.0, 1102.6691992402248, 1140.589387820384, 1144.9942750286361, 1172.7009612548916, 1220.1458978714936, 17303.56741081483, 17428.19064290257, 17473.563160920825, 17507.649847002987, 17562.473125806246, 578851.0, 580797.0, 582717.0, 583891.0, 585284.0, 43002.35496467556, 43529.56470435255, 43641.78179109084, 43762.78118609387, 43814.90462738457, 1275.7065874848836, 1339.752145853001, 1343.726948304382, 1351.2635613590617, 1369.869862363054, 31532.0, 31948.52077218797, 32439.83780081179, 32649.025473031194, 33000.174995625304, 51331.486685134165, 51823.0, 51997.7400112997, 52095.73952130215, 52214.47785522096, 514485.0, 515787.0, 516617.0, 516930.0, 517012.0, 28039.71960280371, 28329.150125496268, 28500.85749571239, 28671.569926450702, 29026.27434314159, 48723.75638121787, 48868.75565622149, 49118.508814911394, 49696.75151624363, 49772.25341619951, 42521.36217956671, 43006.0, 43357.56642433661, 44482.332765009196, 44571.554284458034, 42760.358594620484, 42828.0, 43786.34320485131, 44013.33979990239, 44497.77751111224, 41955.160896781286, 42262.15475690408, 42410.5758942419, 43293.0, 43299.35050974175, 37742.0, 38153.09234538318, 38337.23325533418, 38525.0, 39118.60881391264, 28872.855635722528, 28963.855180724804, 29118.854405727834, 29311.120666380044, 29398.55902161512], "value": 18736.64848522394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.1011762827866, 392.4838836929438, 395.0676403687298, 395.9128991621842, 418.95600961899, 13902.582922512316, 18172.636547269045, 19673.50816229595, 20168.59662806743, 20219.898900505494, 19587.118579663915, 19784.30754923578, 20195.899020504912, 20304.289349872757, 20345.28791492298, 5730.656160630355, 5794.0, 5886.20536227608, 5888.322842873082, 5902.409759024084, 5521.116621340586, 5765.1928729977835, 5796.768129274824, 5813.01178799603, 5827.796027139051, 5772.3361813391575, 5844.211031510756, 5850.122481627747, 5884.0, 5900.498457631106, 5886.499647529944, 5887.087501437262, 5894.322152952423, 6084.117802918552, 6097.298810636745, 5566.248556444869, 5725.312962444534, 5752.165935939265, 5819.592628516006, 5823.301203855522, 14404.279786010658, 14416.0, 14669.119852808866, 17543.385981490588, 23934.162304319267, 2267.2971378872603, 2411.385096800305, 2520.5463016656995, 2529.557327467704, 2947.0127507285083, 10505.78988420235, 10639.521221545048, 11748.823767643493, 13179.60461186166, 15069.849301506954, 1879.2483006797254, 1904.4477101640507, 2008.2669825513728, 2014.1339224133617, 2020.797920207982, 81943.59028204822, 85636.14363856344, 86381.0, 89207.0, 89393.0, 10483.423411712276, 10680.359178449162, 11245.943770281096, 11254.324740515594, 11396.316221026598, 15555.377784888704, 15573.221338933236, 15580.766288505682, 15686.76469852953, 15691.372345106296, 7511.558743408415, 7657.238835067966, 7661.923380766232, 7793.844123117506, 7897.407694422826, 7207.099112610924, 7260.491765576359, 7392.0, 7420.777376678709, 7432.888506672404, 4767.856964291077, 4788.1381351356395, 4809.0, 4836.419629644465, 4890.926636100461, 1995.4412764425983, 2024.2995883457966, 2039.4901274681329, 2061.3815855243365, 2068.2761033638108, 961.9422834629945, 1000.2648053680539, 1013.8631284776608, 1064.760428903506, 1083.2471432354596, 19548.804511954982, 20462.283820066226, 20583.0, 20599.176032958512, 20689.379318620464, 1000.7097941596855, 1029.583018877356, 1052.4369462337613, 1056.039004505896, 1091.939943303126, 10968.835467467994, 11774.94112529449, 11900.940495297467, 12542.0, 12604.243745375123, 413661.0, 421121.0, 425688.0, 585933.0, 612736.0, 98097.50951245341, 99239.0, 102124.0, 102225.0, 102292.0, 997.2520609542843, 1008.7377281906757, 1022.8977102289712, 1048.292402628238, 1049.0872940541624, 18260.908695456437, 18271.725924111415, 18717.43847684517, 18984.047185495805, 18999.24003039863, 41810.0, 42437.57562424336, 43067.353989690804, 43326.0, 44452.333215001156, 60725.696371519625, 61272.0, 61972.0, 62407.37592624197, 63274.68362658157, 8467.618957147066, 8715.825683486422, 8763.561821908752, 8764.386492945432, 8765.123487651184, 9374.859377109486, 12597.307148106576, 12665.176763510712, 13488.5279015234, 13540.458381664623, 5914.408559144051, 10732.839007415052, 10862.185336099667, 11014.50434730423, 11056.834147487632, 11402.885971140515, 11465.656030319104, 11519.88480115188, 11537.48081336325, 11877.881221187678, 10461.110805581611, 10649.574017039542, 10747.301425407324, 10968.670939871816, 11227.091394463125, 8367.246947774485, 8367.28878045373, 8598.398112132341, 8617.181367770052, 8886.73339799807, 10355.326903751233, 10733.624323148651, 10952.671419857417, 10993.955574220436, 11107.500162492546], "value": 9285.038293135764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.5354540092571, 1521.5359315408803, 1694.466243133413, 1822.1071674879297, 1850.2783914273427, 8116.1478044805335, 8936.508492032935, 8950.910490895105, 9502.334836561444, 9506.904930950688, 8922.91077089229, 9158.58786354614, 9201.401908875918, 9292.488913109777, 9309.813803723922, 2389.438481956743, 2421.104191449166, 2422.8667423291713, 2425.490646964131, 2430.2952143878256, 2391.3304274802995, 2397.6883005209297, 2412.746661600533, 2422.2733180046002, 2426.6723992260995, 2383.7854593086618, 2392.617181251, 2394.820388470872, 2410.6866107406013, 2412.1798588479915, 2335.8481698689616, 2350.717913850349, 2364.5034542746043, 2365.727941286757, 2382.892769825362, 2286.22268428735, 2307.6884620576175, 2313.1788215183537, 2318.7797159269844, 2323.1520495019195, 9274.860877086849, 9348.485833279166, 9385.624575016991, 9413.058694130601, 9432.858507122399, 5517.227588137664, 5628.634138781007, 5672.546196304285, 5672.716364181774, 5673.801416950387, 3412.3687117883023, 3546.592141903688, 3565.5899571549344, 3626.4560315952554, 3642.7267954903223, 1207.3057991654746, 1217.7564487102527, 1220.8473940757406, 1243.9440225189799, 1262.072376803049, 12777.10560260782, 12814.231146131262, 12882.0, 12895.935520322431, 12953.611391658265, 4464.732116072981, 4571.314302854598, 4695.506971767915, 4730.692504987233, 4835.903281934342, 10222.182225421948, 10225.693229203136, 10242.948785256027, 10255.7436064099, 10259.076683098558, 5507.0, 5514.448555144534, 5517.034518959166, 5521.2270282160525, 5524.254225679562, 4355.499117601516, 4980.825671101494, 5131.332926719502, 5133.820316288912, 5139.537441630271, 3720.3489389356755, 3831.367824308958, 3950.4271880577157, 3953.1698343347643, 3965.980170099189, 1144.6721802708819, 1176.6528873982024, 1178.8526434195726, 1183.2545496337252, 1184.691980085184, 915.8763566918514, 1013.7364285285731, 1013.9138173255355, 1027.8612387327764, 1043.212374657129, 6338.207724034496, 6421.839454013687, 6426.196725409324, 6442.098106265126, 6486.4486518646445, 472.0182021395489, 482.2982560374717, 488.18960525527456, 1048.124815778818, 1055.145332280855, 4461.620762235181, 4508.571685689854, 4537.342085397665, 4545.409096817459, 4572.657050721209, 10971.561137554569, 11145.108391328675, 11266.605668801552, 11491.42542872853, 11666.0, 10955.890441095646, 11373.94313028446, 11397.0, 11591.24656897299, 11679.474423650956, 8406.201410865959, 8592.226699596942, 8669.956650216709, 8675.696350627697, 8690.08754080825, 6254.2807577129215, 6558.1802274715665, 6563.737450501926, 6587.9670601646685, 6658.267590564937, 9998.350107243006, 10361.119304859172, 10607.0, 10632.362058276529, 10769.623063193065, 10165.390076595428, 10675.252732308974, 10690.786184276427, 10697.251192416456, 10763.085137763377, 7231.204567497676, 7992.84014319722, 8070.6368213431715, 8220.136885627162, 8234.835303294021, 9179.678711245075, 9187.265018798347, 9202.171804537356, 9205.125513076247, 9289.303302252494, 8099.514029158269, 8316.958415207886, 8427.073021967457, 8442.577871106543, 8508.0, 7867.449278550446, 8017.318527925192, 8187.959060204661, 8208.425410221465, 8383.58082095905, 7485.363744081596, 7494.3629791466155, 7623.733169339046, 7625.389968802371, 7654.961725191339, 5353.625246232727, 5384.9192262116885, 5397.703126327932, 5450.073487507213, 5546.667199968015, 5556.055470569932, 5605.607607467601, 5607.523360514238, 5634.605577609692, 5670.943290567042], "value": 4808.636313840684, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.23293541322664, 337.23447773554034, 344.16368225212733, 347.6627671158975, 348.4529289016244, 5667.8583035424135, 5683.5169010634145, 5723.6263296808775, 5730.713464326788, 5793.42065793421, 5622.32532096148, 5639.68981706006, 5669.461401166883, 5692.430756924306, 5728.22668939693, 4184.3305071188615, 4197.538270790211, 4320.65434765218, 4321.373400856874, 4338.479382474107, 4307.935380969288, 4310.956890431087, 4328.156009578133, 4344.304911214206, 4384.561543845622, 4319.114581510798, 4345.8478953236645, 4347.630451411634, 4348.499922508904, 4348.652107831382, 4255.659547236229, 4258.87223383299, 4293.184294983943, 4296.613304802583, 4323.2490841209365, 3753.568339640949, 3759.9436008459893, 3775.131719704456, 3811.7522361046445, 3820.2741479118877, 5514.944850551483, 5529.447055294479, 5533.889322213533, 5575.832725018256, 5576.414476479952, 4828.420589529243, 4952.7028378297055, 4969.552740253394, 4990.201567749143, 5011.2483127530795, 5785.942140578624, 5832.737526811304, 5849.444302791228, 5875.8248350330105, 5894.58737888348, 4115.259253334399, 4138.91722165558, 4139.834406623731, 4175.498940127174, 4179.373094035888, 5991.55063370249, 6064.060070689095, 6080.543959203033, 6082.665453400061, 6087.003758080406, 4250.787460627018, 4256.7445953242905, 4258.850940217078, 4261.531231564525, 4262.360645903139, 4286.6999310047995, 4306.181825453154, 4319.589638984291, 4325.167015604721, 4326.382538564187, 4758.095961767253, 4916.8770780730765, 4922.163232250526, 4949.455559888409, 4953.2074868020945, 5894.528437724972, 5906.586538942319, 5927.762889484458, 5963.522918166623, 5963.970180149158, 1496.9027013244104, 1517.8937474376687, 1529.8699610533229, 1531.29560402214, 1538.1847620761014, 973.3721749471692, 973.571628483465, 984.5274268351232, 988.6935050134481, 995.233670074039, 5018.698878067327, 5035.446100928895, 5057.8229761958155, 5090.949090509122, 5106.412762532282, 5268.394134674485, 5324.600654950894, 5347.25138480613, 5349.849782296747, 5358.223057656696, 4855.975720121447, 5012.473690262543, 5012.799488020439, 5033.647644664911, 5083.694978301313, 2841.3606938439098, 2843.7298456646586, 2850.9287267818054, 2863.914082577526, 2878.769698424121, 5405.8107966221, 5471.863203419946, 5480.945190548123, 5529.806456773994, 5559.499645031967, 5785.334686511021, 6277.905831412532, 6287.622742635456, 6311.589746666452, 6311.652859092702, 6292.811215663446, 6332.68336583169, 6351.872962540816, 6385.744570217139, 6402.679866006681, 6004.369541198112, 6095.390460954047, 6117.204763380732, 6134.4172303631085, 6145.324014358328, 6050.788222412194, 6065.2418447694035, 6068.939310607014, 6094.024956007018, 6117.143599896107, 6065.332813390612, 6302.243730752156, 6372.872542549216, 6381.8723625528155, 6382.138411314413, 4264.445622069111, 4296.357739989946, 4323.113761678911, 4327.134573085333, 4339.218940590597, 5872.3574391524835, 5918.73365698536, 6029.457348838626, 6174.598651087665, 6204.100405441276, 5906.316699740553, 5943.7028148591535, 5977.402259774161, 6015.308239552332, 6059.909101363395, 5788.642587299272, 5918.733656985532, 5931.733072011683, 5970.223870896755, 6032.276126864805, 5833.445822646841, 5857.765689372548, 5876.796201424466, 5880.941190588211, 5912.645241285537, 5966.373530779206, 5991.3409524953095, 6016.6690832002905, 6043.637381757108, 6055.788047418319, 5684.289463817023, 5844.736986835687, 5850.824475265749, 5867.501262392744, 5900.321463031806], "value": 4420.918233196033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.3332134364446, 802.7391097893186, 830.617915758751, 863.8704194370846, 868.7654333330005, 16444.671106577876, 16930.492085237463, 16979.235934382952, 17037.65924681507, 17114.486565403044, 15287.617809554768, 15386.69226615467, 15405.306761195745, 15418.460353887616, 15483.69032619347, 661.9602823830561, 799.3924617290843, 800.8358286551272, 802.8554860125175, 820.9425340226187, 804.4449329962337, 808.5391326943644, 816.338765599863, 816.5957850863831, 820.0446479850966, 872.2585802068255, 874.1957399192758, 875.5272153037353, 876.6274333408307, 878.7583414560983, 868.1145231863495, 868.1708967935606, 869.3349587565517, 870.7170169694842, 874.5802015032788, 635.8601107756286, 636.0300541673938, 636.805774238857, 637.0253512126454, 638.5849198021277, 14602.70794584113, 14622.634434139232, 14745.336459859333, 14766.0, 14769.33537990793, 15574.532764017098, 15620.218989050501, 15819.92090039554, 15867.444639437565, 15919.522414327588, 10872.945635271852, 11222.0, 11430.969953478634, 11531.884681153166, 12156.574519891761, 4032.8185231664647, 4037.858674946363, 4069.1454794492897, 4078.12320351123, 4127.731697439687, 69861.3013869865, 81901.18098818995, 83907.58046209729, 84415.57792211, 85101.14898850994, 11262.605808796652, 11305.152113591514, 11331.886681133248, 11474.885251147381, 11545.422728863523, 22112.22607208772, 22525.0, 22550.323490294988, 22616.886915565316, 22636.773632263797, 8863.379563430626, 8929.419587726778, 9161.633534658673, 9258.213051890665, 9288.628454861864, 4665.0, 4709.929351059737, 4792.185328494164, 4857.417109946829, 4926.113299606033, 3623.9818800905828, 3640.381135207021, 3707.5736290326417, 3732.104294969188, 3744.26986737589, 680.4080450008425, 681.2234053179379, 686.8221000983237, 689.0387908867102, 700.1772916822713, 608.382491770853, 616.9850595770023, 644.1497223664811, 678.5352033856824, 742.1687709765098, 10033.849492257623, 10117.155931917672, 10216.235025103088, 10512.526936287886, 10780.51487683056, 678.6267552845915, 690.975815846453, 735.7932989896574, 744.144234130754, 750.6275942634178, 5124.461931497213, 5134.383873935077, 5139.326567578998, 5150.768215430315, 5220.634555581149, 66638.66680666566, 73678.6316068427, 95602.52198738961, 117797.0, 121278.3936080314, 103023.48488257511, 103883.0, 104312.47843760732, 104838.0, 106364.0, 79871.60064199643, 80332.19667803364, 82929.17070829215, 91772.0, 94816.52591736997, 9542.85685714701, 10303.74722212602, 10351.948240258751, 10528.947355263175, 10559.668403694539, 38463.615363846, 48906.5109348902, 49947.250791237435, 52697.7365113172, 53282.46717532775, 52075.0, 53126.468735312155, 64912.35087649063, 76164.81362981896, 82868.0, 12580.685482862635, 12588.30764307972, 12637.87362126367, 12666.0, 12966.80549791735, 15459.381624735335, 15575.766363504783, 15958.281877315316, 16033.0, 16090.195490225677, 14823.40706371733, 14887.330070147085, 14990.400383984519, 15180.544583662508, 15740.842591573937, 14262.133701910401, 14522.927385363006, 14540.709185816437, 14800.407983680963, 14800.925995369955, 14503.85496145025, 14693.118412895261, 14968.700625987201, 15047.247637617857, 15374.9231253843, 11322.37726924994, 11647.184697071123, 11702.765944680888, 11712.238704484182, 12033.157678962389, 11239.213255072067, 11481.196316258116, 11496.137789665641, 11754.23597466162, 11807.409629518661], "value": 7751.441280614583, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 105.0, 111.0, 112.0, 113.0, 114.0, 112.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 144.0, 170.0, 124.0, 145.0, 147.0, 121.0, 182.0, 117.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 161.0, 164.0, 168.0, 165.0, 161.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 170.0, 76.0, 76.0, 75.0, 76.0, 178.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 152.0, 84.0, 83.0, 84.0, 143.0, 84.0, 84.0, 157.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 56.0, 52.0, 52.0, 52.0, 52.0, 51.0, 52.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 76.0, 76.0, 79.0, 76.0, 75.0, 87.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 137.0, 122.0, 121.0, 123.0, 124.0, 129.0, 130.0, 150.0, 123.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 157.0, 159.0, 163.0, 154.0, 159.0, 156.0, 156.0, 162.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 72.0, 63.0, 65.0, 67.0, 63.0, 64.0, 63.0, 63.0], "value": 65.4, "unit": "score"}]}]} 20:48:38 INFO - Return code: 0 20:48:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:48:38 ERROR - # TBPL SUCCESS # 20:48:38 INFO - Running post-action listener: _resource_record_post_action 20:48:38 INFO - ##### 20:48:38 INFO - ##### Finished run-tests step (success) 20:48:38 INFO - ##### 20:48:38 INFO - Running post-run listener: _resource_record_post_run 20:48:38 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 571002880; Read time: 12; Write time: 451832 20:48:38 INFO - TinderboxPrint: CPU usage
13.3% 20:48:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:48:38 INFO - TinderboxPrint: I/O write bytes / time
571,002,880 / 451,832 20:48:38 INFO - TinderboxPrint: CPU idle
8,226.5 (86.6%) 20:48:38 INFO - TinderboxPrint: CPU user
1,215.3 (12.8%) 20:48:38 INFO - TinderboxPrint: Swap in / out
0 / 0 20:48:38 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 273027072; Read time: 0; Write time: 269748 20:48:38 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297521152; Read time: 0; Write time: 182084 20:48:39 INFO - Running post-run listener: _upload_blobber_files 20:48:39 INFO - Blob upload gear active. 20:48:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:48:39 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:48:39 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:48:39 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:48:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:48:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:48:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:48:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:40 INFO - (blobuploader) - INFO - Done attempting. 20:48:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:48:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:48:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:44 INFO - (blobuploader) - INFO - Done attempting. 20:48:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:48:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:45 INFO - (blobuploader) - INFO - Done attempting. 20:48:45 INFO - (blobuploader) - INFO - Iteration through files over. 20:48:45 INFO - Return code: 0 20:48:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:48:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:48:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8edb3c8bb59acc9a5aa1cd902467771ba1231bbdb7e1a0cf4a288f200d74154d8ca93d3f9ee0e2df520c686f02a993015e4450da5d1f6592cd05465054723e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e954b3171cead37523ec6236a59d07cc6909fd0460abb67eaba634c60f833428283341e210789a783a549e1148aafbced275a0149c9a7e0ef879878a4e51f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77f8ec74ca0f614c018f22ccfc20a54ce4b11e03e41380bdac248e718ad66e7d1614e887bb4627fc4ae350fe751e8b3be3eb31eeea506bfa251f520f1890d516"} 20:48:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:48:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:48:45 INFO - Contents: 20:48:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8edb3c8bb59acc9a5aa1cd902467771ba1231bbdb7e1a0cf4a288f200d74154d8ca93d3f9ee0e2df520c686f02a993015e4450da5d1f6592cd05465054723e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e954b3171cead37523ec6236a59d07cc6909fd0460abb67eaba634c60f833428283341e210789a783a549e1148aafbced275a0149c9a7e0ef879878a4e51f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77f8ec74ca0f614c018f22ccfc20a54ce4b11e03e41380bdac248e718ad66e7d1614e887bb4627fc4ae350fe751e8b3be3eb31eeea506bfa251f520f1890d516"} 20:48:45 INFO - Running post-run listener: copy_logs_to_upload_dir 20:48:45 INFO - Copying logs to upload dir... 20:48:45 INFO - mkdir: /builds/slave/test/build/upload/logs 20:48:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.248751 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-18 20:48:44.949870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:48:44.957355) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8edb3c8bb59acc9a5aa1cd902467771ba1231bbdb7e1a0cf4a288f200d74154d8ca93d3f9ee0e2df520c686f02a993015e4450da5d1f6592cd05465054723e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e954b3171cead37523ec6236a59d07cc6909fd0460abb67eaba634c60f833428283341e210789a783a549e1148aafbced275a0149c9a7e0ef879878a4e51f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77f8ec74ca0f614c018f22ccfc20a54ce4b11e03e41380bdac248e718ad66e7d1614e887bb4627fc4ae350fe751e8b3be3eb31eeea506bfa251f520f1890d516"} 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.011291 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8edb3c8bb59acc9a5aa1cd902467771ba1231bbdb7e1a0cf4a288f200d74154d8ca93d3f9ee0e2df520c686f02a993015e4450da5d1f6592cd05465054723e09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e954b3171cead37523ec6236a59d07cc6909fd0460abb67eaba634c60f833428283341e210789a783a549e1148aafbced275a0149c9a7e0ef879878a4e51f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77f8ec74ca0f614c018f22ccfc20a54ce4b11e03e41380bdac248e718ad66e7d1614e887bb4627fc4ae350fe751e8b3be3eb31eeea506bfa251f520f1890d516"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:48:44.982363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:48:44.982681) ========= 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=337fe3f4b1febe37b85fccc40000019e-1468898893.955636-828294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:48:45.067640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:48:45.067990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:48:45.068291) ========= ========= Total master_lag: 0.18 =========