builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1452626272.43 results: success (0) buildid: 20160112083253 builduid: 46f5211979b14d738bf800baa0ddd7b6 revision: 98687c28986cb707736bd06d99366332b794b777 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.433687) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.434133) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.434417) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004359 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.451705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.452018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.464073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.464475) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.513589) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.513900) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.514263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.514552) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 11:17:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.8M=0s 2016-01-12 11:17:52 (84.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.625456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.625791) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021041 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.675361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:52.675722) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98687c28986cb707736bd06d99366332b794b777 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 98687c28986cb707736bd06d99366332b794b777 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 11:17:52,844 truncating revision to first 12 chars 2016-01-12 11:17:52,844 Setting DEBUG logging. 2016-01-12 11:17:52,844 attempt 1/10 2016-01-12 11:17:52,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98687c28986c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 11:17:53,116 unpacking tar archive at: fx-team-98687c28986c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:53.318803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:53.319229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:53.330107) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:53.330556) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 11:17:53.331127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-12 11:17:53.331483) ========= /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-pgo/. (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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:53 INFO - MultiFileLogger online at 20160112 11:17:53 in /builds/slave/test-pgo 11:17:53 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 11:17:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:17:53 INFO - {'append_to_log': False, 11:17:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:17:53 INFO - 'blob_upload_branch': 'Fx-Team', 11:17:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:17:53 INFO - 'branch': 'Fx-Team', 11:17:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:53 INFO - 'config_files': ('talos/linux_config.py',), 11:17:53 INFO - 'default_actions': ('clobber', 11:17:53 INFO - 'read-buildbot-config', 11:17:53 INFO - 'download-and-extract', 11:17:53 INFO - 'populate-webroot', 11:17:53 INFO - 'create-virtualenv', 11:17:53 INFO - 'install', 11:17:53 INFO - 'run-tests'), 11:17:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:53 INFO - 'download_minidump_stackwalk': True, 11:17:53 INFO - 'download_symbols': 'ondemand', 11:17:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:53 INFO - 'installer_path': 'installer.exe', 11:17:53 INFO - 'log_level': 'info', 11:17:53 INFO - 'log_name': 'talos', 11:17:53 INFO - 'log_to_console': True, 11:17:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:53 INFO - 'opt_config_files': (), 11:17:53 INFO - 'pip_index': False, 11:17:53 INFO - 'sps_profile': False, 11:17:53 INFO - 'sps_profile_interval': 0, 11:17:53 INFO - 'suite': 'dromaeojs-e10s', 11:17:53 INFO - 'system_bits': '32', 11:17:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:53 INFO - 'title': 'talos-linux64-ix-044', 11:17:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:53 INFO - 'use_talos_json': True, 11:17:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:17:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:53 INFO - 'work_dir': 'build'} 11:17:53 INFO - ##### 11:17:53 INFO - ##### Running clobber step. 11:17:53 INFO - ##### 11:17:53 INFO - Running pre-action listener: _resource_record_pre_action 11:17:53 INFO - Running main action method: clobber 11:17:53 INFO - rmtree: /builds/slave/test-pgo/build 11:17:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:17:54 INFO - Running post-action listener: _resource_record_post_action 11:17:54 INFO - ##### 11:17:54 INFO - ##### Running read-buildbot-config step. 11:17:54 INFO - ##### 11:17:54 INFO - Running pre-action listener: _resource_record_pre_action 11:17:54 INFO - Running main action method: read_buildbot_config 11:17:54 INFO - Using buildbot properties: 11:17:54 INFO - { 11:17:54 INFO - "project": "", 11:17:54 INFO - "product": "firefox", 11:17:54 INFO - "script_repo_revision": "production", 11:17:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:17:54 INFO - "repository": "", 11:17:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:17:54 INFO - "buildid": "20160112083253", 11:17:54 INFO - "pgo_build": "True", 11:17:54 INFO - "basedir": "/builds/slave/test-pgo", 11:17:54 INFO - "buildnumber": 198, 11:17:54 INFO - "slavename": "talos-linux64-ix-044", 11:17:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:17:54 INFO - "platform": "ubuntu64_hw", 11:17:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:17:54 INFO - "branch": "fx-team", 11:17:54 INFO - "repo_path": "integration/fx-team", 11:17:54 INFO - "revision": "98687c28986cb707736bd06d99366332b794b777", 11:17:54 INFO - "stage_platform": "linux64-pgo", 11:17:54 INFO - "builduid": "46f5211979b14d738bf800baa0ddd7b6", 11:17:54 INFO - "slavebuilddir": "test" 11:17:54 INFO - } 11:17:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:17:54 INFO - Running post-action listener: _resource_record_post_action 11:17:54 INFO - ##### 11:17:54 INFO - ##### Running download-and-extract step. 11:17:54 INFO - ##### 11:17:54 INFO - Running pre-action listener: _resource_record_pre_action 11:17:54 INFO - Running main action method: download_and_extract 11:17:54 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:54 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json 11:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json 11:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:17:54 INFO - Downloaded 1302 bytes. 11:17:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:17:54 INFO - Using the following test package requirements: 11:17:54 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:54 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:54 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:54 INFO - u'jsshell-linux-x86_64.zip'], 11:17:54 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:54 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:54 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:17:54 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:17:54 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:54 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:54 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:54 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:57 INFO - Downloaded 24027009 bytes. 11:17:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:17:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:17:58 INFO - Return code: 0 11:17:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:17:58 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')]} 11:17:58 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:01 INFO - Downloaded 24027009 bytes. 11:18:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:18:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:18:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:18:02 INFO - Return code: 0 11:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:02 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:18:04 INFO - Downloaded 11132285 bytes. 11:18:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:18:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:18:04 INFO - Return code: 0 11:18:04 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')]} 11:18:04 INFO - https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:18:07 INFO - Downloaded 55746196 bytes. 11:18:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:18:07 INFO - mkdir: /builds/slave/test-pgo/properties 11:18:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:18:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:18:07 INFO - Contents: 11:18:07 INFO - build_url:https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:18:07 INFO - Running post-action listener: _resource_record_post_action 11:18:07 INFO - Running post-action listener: set_extra_try_arguments 11:18:07 INFO - ##### 11:18:07 INFO - ##### Running populate-webroot step. 11:18:07 INFO - ##### 11:18:07 INFO - Running pre-action listener: _resource_record_pre_action 11:18:07 INFO - Running main action method: populate_webroot 11:18:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:07 INFO - '--tppagecycles', 11:18:07 INFO - '7'], 11:18:07 INFO - 'tests': ['tsvgm']}}, 11:18:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:18:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:18:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:18:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'tests': ['damp', 'tps']}, 11:18:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['damp', 'tps']}, 11:18:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:18:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:07 INFO - 'other': {'tests': ['a11yr', 11:18:07 INFO - 'ts_paint', 11:18:07 INFO - 'tpaint', 11:18:07 INFO - 'sessionrestore', 11:18:07 INFO - 'sessionrestore_no_auto_restore']}, 11:18:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['a11yr', 11:18:07 INFO - 'ts_paint', 11:18:07 INFO - 'tpaint', 11:18:07 INFO - 'sessionrestore', 11:18:07 INFO - 'sessionrestore_no_auto_restore']}, 11:18:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['a11yr', 11:18:07 INFO - 'ts_paint', 11:18:07 INFO - 'tpaint', 11:18:07 INFO - 'sessionrestore', 11:18:07 INFO - 'sessionrestore_no_auto_restore']}, 11:18:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['a11yr', 11:18:07 INFO - 'ts_paint', 11:18:07 INFO - 'tpaint', 11:18:07 INFO - 'sessionrestore', 11:18:07 INFO - 'sessionrestore_no_auto_restore']}, 11:18:07 INFO - 'other_l64': {'tests': ['a11yr', 11:18:07 INFO - 'ts_paint', 11:18:07 INFO - 'tpaint', 11:18:07 INFO - 'sessionrestore', 11:18:07 INFO - 'sessionrestore_no_auto_restore']}, 11:18:07 INFO - 'other_nol64': {'tests': ['a11yr', 11:18:07 INFO - 'ts_paint', 11:18:07 INFO - 'tpaint', 11:18:07 INFO - 'sessionrestore', 11:18:07 INFO - 'sessionrestore_no_auto_restore']}, 11:18:07 INFO - 'svgr': {'tests': ['tsvgx', 11:18:07 INFO - 'tsvgr_opacity', 11:18:07 INFO - 'tart', 11:18:07 INFO - 'tscrollx', 11:18:07 INFO - 'cart']}, 11:18:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['tsvgx', 11:18:07 INFO - 'tsvgr_opacity', 11:18:07 INFO - 'tart', 11:18:07 INFO - 'tscrollx', 11:18:07 INFO - 'cart']}, 11:18:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'tests': ['tp5o']}, 11:18:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'talos_options': ['--e10s'], 11:18:07 INFO - 'tests': ['tp5o']}, 11:18:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'talos_options': ['--xperf_path', 11:18:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:07 INFO - 'tests': ['tp5n']}, 11:18:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:07 INFO - 'talos_options': ['--e10s', 11:18:07 INFO - '--xperf_path', 11:18:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:07 INFO - 'tests': ['tp5n']}}, 11:18:07 INFO - 'talos.zip': {'path': '', 11:18:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:07 INFO - Running post-action listener: _resource_record_post_action 11:18:07 INFO - ##### 11:18:07 INFO - ##### Running create-virtualenv step. 11:18:07 INFO - ##### 11:18:07 INFO - Running pre-action listener: _resource_record_pre_action 11:18:07 INFO - Running main action method: create_virtualenv 11:18:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:18:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:18:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:18:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:07 INFO - Using real prefix '/usr' 11:18:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:18:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:10 INFO - Installing pip.................done. 11:18:10 INFO - Return code: 0 11:18:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 11:18:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:18:10 INFO - Using env: {'DISPLAY': ':0', 11:18:10 INFO - 'HOME': '/home/cltbld', 11:18:10 INFO - 'LANG': 'en_US.UTF-8', 11:18:10 INFO - 'LANGUAGE': 'en_US:en', 11:18:10 INFO - 'LOGNAME': 'cltbld', 11:18:10 INFO - 'MAIL': '/var/mail/cltbld', 11:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:10 INFO - 'MOZ_NO_REMOTE': '1', 11:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:10 INFO - 'NO_EM_RESTART': '1', 11:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:10 INFO - 'SHELL': '/bin/bash', 11:18:10 INFO - 'SHLVL': '1', 11:18:10 INFO - 'TERM': 'linux', 11:18:10 INFO - 'TMOUT': '86400', 11:18:10 INFO - 'USER': 'cltbld', 11:18:10 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:10 INFO - '_': '/tools/buildbot/bin/python'} 11:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:18:10 INFO - Cleaning up... 11:18:10 INFO - Return code: 0 11:18:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test-pgo/build 11:18:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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>=0.7.1 11:18:10 INFO - Using env: {'DISPLAY': ':0', 11:18:10 INFO - 'HOME': '/home/cltbld', 11:18:10 INFO - 'LANG': 'en_US.UTF-8', 11:18:10 INFO - 'LANGUAGE': 'en_US:en', 11:18:10 INFO - 'LOGNAME': 'cltbld', 11:18:10 INFO - 'MAIL': '/var/mail/cltbld', 11:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:10 INFO - 'MOZ_NO_REMOTE': '1', 11:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:10 INFO - 'NO_EM_RESTART': '1', 11:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:10 INFO - 'SHELL': '/bin/bash', 11:18:10 INFO - 'SHLVL': '1', 11:18:10 INFO - 'TERM': 'linux', 11:18:10 INFO - 'TMOUT': '86400', 11:18:10 INFO - 'USER': 'cltbld', 11:18:10 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:10 INFO - '_': '/tools/buildbot/bin/python'} 11:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:10 INFO - Downloading/unpacking psutil>=0.7.1 11:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:18:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:18:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:12 INFO - Installing collected packages: psutil 11:18:12 INFO - Running setup.py install for psutil 11:18:12 INFO - building 'psutil._psutil_linux' extension 11:18:12 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 11:18:12 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 11:18:12 INFO - building 'psutil._psutil_posix' extension 11:18:12 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 11:18:12 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 11:18:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:12 INFO - Successfully installed psutil 11:18:12 INFO - Cleaning up... 11:18:12 INFO - Return code: 0 11:18:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0'] in /builds/slave/test-pgo/build 11:18:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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.0.0 11:18:12 INFO - Using env: {'DISPLAY': ':0', 11:18:12 INFO - 'HOME': '/home/cltbld', 11:18:12 INFO - 'LANG': 'en_US.UTF-8', 11:18:12 INFO - 'LANGUAGE': 'en_US:en', 11:18:12 INFO - 'LOGNAME': 'cltbld', 11:18:12 INFO - 'MAIL': '/var/mail/cltbld', 11:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:12 INFO - 'MOZ_NO_REMOTE': '1', 11:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:12 INFO - 'NO_EM_RESTART': '1', 11:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:12 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:12 INFO - 'SHELL': '/bin/bash', 11:18:12 INFO - 'SHLVL': '1', 11:18:12 INFO - 'TERM': 'linux', 11:18:12 INFO - 'TMOUT': '86400', 11:18:12 INFO - 'USER': 'cltbld', 11:18:12 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:12 INFO - '_': '/tools/buildbot/bin/python'} 11:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:18:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:18:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:18:15 INFO - Installing collected packages: mozsystemmonitor 11:18:15 INFO - Running setup.py install for mozsystemmonitor 11:18:15 INFO - Successfully installed mozsystemmonitor 11:18:15 INFO - Cleaning up... 11:18:15 INFO - Return code: 0 11:18:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 11:18:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:18:15 INFO - Using env: {'DISPLAY': ':0', 11:18:15 INFO - 'HOME': '/home/cltbld', 11:18:15 INFO - 'LANG': 'en_US.UTF-8', 11:18:15 INFO - 'LANGUAGE': 'en_US:en', 11:18:15 INFO - 'LOGNAME': 'cltbld', 11:18:15 INFO - 'MAIL': '/var/mail/cltbld', 11:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:15 INFO - 'MOZ_NO_REMOTE': '1', 11:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:15 INFO - 'NO_EM_RESTART': '1', 11:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:15 INFO - 'SHELL': '/bin/bash', 11:18:15 INFO - 'SHLVL': '1', 11:18:15 INFO - 'TERM': 'linux', 11:18:15 INFO - 'TMOUT': '86400', 11:18:15 INFO - 'USER': 'cltbld', 11:18:15 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:15 INFO - '_': '/tools/buildbot/bin/python'} 11:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:15 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:15 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 11:18:15 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 11:18:15 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 11:18:15 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 11:18:15 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 11:18:15 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 11:18:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:18:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:18:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:18:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - Downloading docopt-0.6.1.tar.gz 11:18:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:18:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:17 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:17 INFO - Running setup.py install for blobuploader 11:18:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:18:17 INFO - Running setup.py install for requests 11:18:18 INFO - Running setup.py install for docopt 11:18:18 INFO - Successfully installed blobuploader requests docopt 11:18:18 INFO - Cleaning up... 11:18:18 INFO - Return code: 0 11:18:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:18: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')]} 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 11:18:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 11:18:18 INFO - Using env: {'DISPLAY': ':0', 11:18:18 INFO - 'HOME': '/home/cltbld', 11:18:18 INFO - 'LANG': 'en_US.UTF-8', 11:18:18 INFO - 'LANGUAGE': 'en_US:en', 11:18:18 INFO - 'LOGNAME': 'cltbld', 11:18:18 INFO - 'MAIL': '/var/mail/cltbld', 11:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:18 INFO - 'MOZ_NO_REMOTE': '1', 11:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:18 INFO - 'NO_EM_RESTART': '1', 11:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:18 INFO - 'SHELL': '/bin/bash', 11:18:18 INFO - 'SHLVL': '1', 11:18:18 INFO - 'TERM': 'linux', 11:18:18 INFO - 'TMOUT': '86400', 11:18:18 INFO - 'USER': 'cltbld', 11:18:18 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:18 INFO - '_': '/tools/buildbot/bin/python'} 11:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:18:18 INFO - Running setup.py (path:/tmp/pip-0pHeSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:18:18 INFO - Running setup.py (path:/tmp/pip-ohHTiR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:18:18 INFO - Running setup.py (path:/tmp/pip-4VCKtK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:18:18 INFO - Running setup.py (path:/tmp/pip-j0qOCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:18:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:18:18 INFO - Running setup.py (path:/tmp/pip-YA3RN8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:18:19 INFO - Running setup.py (path:/tmp/pip-0zlRya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:18:19 INFO - Running setup.py (path:/tmp/pip-nkTBQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:18:19 INFO - Running setup.py (path:/tmp/pip-DeFH80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:18:19 INFO - Running setup.py (path:/tmp/pip-_EID7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:18:19 INFO - Running setup.py (path:/tmp/pip-pf6nAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:18:19 INFO - Running setup.py (path:/tmp/pip-7PrhcN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:18:19 INFO - Running setup.py (path:/tmp/pip-WJc95F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:18:19 INFO - Running setup.py (path:/tmp/pip-yfI9qX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:18:19 INFO - Running setup.py (path:/tmp/pip-Z_PUH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:18:19 INFO - Running setup.py (path:/tmp/pip-QReXi_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:18:19 INFO - Running setup.py (path:/tmp/pip-9FT9bV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:18:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:18:19 INFO - Running setup.py (path:/tmp/pip-SPVRpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:18:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:19 INFO - Running setup.py install for manifestparser 11:18:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Running setup.py install for mozcrash 11:18:20 INFO - Running setup.py install for mozdebug 11:18:20 INFO - Running setup.py install for mozdevice 11:18:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Running setup.py install for mozfile 11:18:20 INFO - Running setup.py install for mozhttpd 11:18:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Running setup.py install for mozinfo 11:18:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Running setup.py install for mozInstall 11:18:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Running setup.py install for mozleak 11:18:20 INFO - Running setup.py install for mozlog 11:18:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:18:20 INFO - Running setup.py install for moznetwork 11:18:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:18:21 INFO - Running setup.py install for mozprocess 11:18:21 INFO - Running setup.py install for mozprofile 11:18:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:18:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:18:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:18:21 INFO - Running setup.py install for mozrunner 11:18:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:18:21 INFO - Running setup.py install for mozscreenshot 11:18:21 INFO - Running setup.py install for moztest 11:18:21 INFO - Running setup.py install for mozversion 11:18:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:18:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:21 INFO - Cleaning up... 11:18:21 INFO - Return code: 0 11:18:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 11:18:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 11:18:21 INFO - Using env: {'DISPLAY': ':0', 11:18:21 INFO - 'HOME': '/home/cltbld', 11:18:21 INFO - 'LANG': 'en_US.UTF-8', 11:18:21 INFO - 'LANGUAGE': 'en_US:en', 11:18:21 INFO - 'LOGNAME': 'cltbld', 11:18:21 INFO - 'MAIL': '/var/mail/cltbld', 11:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:21 INFO - 'MOZ_NO_REMOTE': '1', 11:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:21 INFO - 'NO_EM_RESTART': '1', 11:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:21 INFO - 'SHELL': '/bin/bash', 11:18:21 INFO - 'SHLVL': '1', 11:18:21 INFO - 'TERM': 'linux', 11:18:21 INFO - 'TMOUT': '86400', 11:18:21 INFO - 'USER': 'cltbld', 11:18:21 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:21 INFO - '_': '/tools/buildbot/bin/python'} 11:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:18:21 INFO - Running setup.py (path:/tmp/pip-UW1lst-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:18:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:18:21 INFO - Running setup.py (path:/tmp/pip-rQ6T9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:18:22 INFO - Running setup.py (path:/tmp/pip-TgZ_oK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:18:22 INFO - Running setup.py (path:/tmp/pip-F3iR5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:18:22 INFO - Running setup.py (path:/tmp/pip-lPmYIv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:18:22 INFO - Running setup.py (path:/tmp/pip-jA3NKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:18:22 INFO - Running setup.py (path:/tmp/pip-7V20Qn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:18:22 INFO - Running setup.py (path:/tmp/pip-qlMxV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:18:22 INFO - Running setup.py (path:/tmp/pip-6UY0up-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:18:22 INFO - Running setup.py (path:/tmp/pip-Z1zHZ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:18:22 INFO - Running setup.py (path:/tmp/pip-lx8cA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:18:22 INFO - Running setup.py (path:/tmp/pip-LvGWef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:18:22 INFO - Running setup.py (path:/tmp/pip-XqOclx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:18:22 INFO - Running setup.py (path:/tmp/pip-XSIlAJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:18:22 INFO - Running setup.py (path:/tmp/pip-DWSKrA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:18:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:18:22 INFO - Running setup.py (path:/tmp/pip-YqTuo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:18:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:18:23 INFO - Running setup.py (path:/tmp/pip-skG8Wc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:23 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 11:18:23 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 11:18:23 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 11:18:23 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 11:18:23 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 11:18:23 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 11:18:24 INFO - Downloading blessings-1.5.1.tar.gz 11:18:24 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:18:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:24 INFO - Installing collected packages: blessings 11:18:24 INFO - Running setup.py install for blessings 11:18:25 INFO - Successfully installed blessings 11:18:25 INFO - Cleaning up... 11:18:25 INFO - Return code: 0 11:18:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:18:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:18:25 INFO - Reading from file tmpfile_stdout 11:18:25 INFO - Current package versions: 11:18:25 INFO - argparse == 1.2.1 11:18:25 INFO - blessings == 1.5.1 11:18:25 INFO - blobuploader == 1.2.4 11:18:25 INFO - docopt == 0.6.1 11:18:25 INFO - manifestparser == 1.1 11:18:25 INFO - mozInstall == 1.12 11:18:25 INFO - mozcrash == 0.16 11:18:25 INFO - mozdebug == 0.1 11:18:25 INFO - mozdevice == 0.47 11:18:25 INFO - mozfile == 1.2 11:18:25 INFO - mozhttpd == 0.7 11:18:25 INFO - mozinfo == 0.9 11:18:25 INFO - mozleak == 0.1 11:18:25 INFO - mozlog == 3.1 11:18:25 INFO - moznetwork == 0.27 11:18:25 INFO - mozprocess == 0.22 11:18:25 INFO - mozprofile == 0.28 11:18:25 INFO - mozrunner == 6.11 11:18:25 INFO - mozscreenshot == 0.1 11:18:25 INFO - mozsystemmonitor == 0.0 11:18:25 INFO - moztest == 0.7 11:18:25 INFO - mozversion == 1.4 11:18:25 INFO - psutil == 3.1.1 11:18:25 INFO - requests == 1.2.3 11:18:25 INFO - wsgiref == 0.1.2 11:18:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 11:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 11:18:25 INFO - Using env: {'DISPLAY': ':0', 11:18:25 INFO - 'HOME': '/home/cltbld', 11:18:25 INFO - 'LANG': 'en_US.UTF-8', 11:18:25 INFO - 'LANGUAGE': 'en_US:en', 11:18:25 INFO - 'LOGNAME': 'cltbld', 11:18:25 INFO - 'MAIL': '/var/mail/cltbld', 11:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:25 INFO - 'MOZ_NO_REMOTE': '1', 11:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:25 INFO - 'NO_EM_RESTART': '1', 11:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:25 INFO - 'SHELL': '/bin/bash', 11:18:25 INFO - 'SHLVL': '1', 11:18:25 INFO - 'TERM': 'linux', 11:18:25 INFO - 'TMOUT': '86400', 11:18:25 INFO - 'USER': 'cltbld', 11:18:25 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:25 INFO - '_': '/tools/buildbot/bin/python'} 11:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:18:25 INFO - Cleaning up... 11:18:25 INFO - Return code: 0 11:18:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 11:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 11:18:25 INFO - Using env: {'DISPLAY': ':0', 11:18:25 INFO - 'HOME': '/home/cltbld', 11:18:25 INFO - 'LANG': 'en_US.UTF-8', 11:18:25 INFO - 'LANGUAGE': 'en_US:en', 11:18:25 INFO - 'LOGNAME': 'cltbld', 11:18:25 INFO - 'MAIL': '/var/mail/cltbld', 11:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:25 INFO - 'MOZ_NO_REMOTE': '1', 11:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:25 INFO - 'NO_EM_RESTART': '1', 11:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:25 INFO - 'SHELL': '/bin/bash', 11:18:25 INFO - 'SHLVL': '1', 11:18:25 INFO - 'TERM': 'linux', 11:18:25 INFO - 'TMOUT': '86400', 11:18:25 INFO - 'USER': 'cltbld', 11:18:25 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:25 INFO - '_': '/tools/buildbot/bin/python'} 11:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:25 INFO - Downloading/unpacking jsonschema 11:18:25 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 11:18:25 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 11:18:25 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 11:18:25 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 11:18:25 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 11:18:25 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 11:18:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:18:27 INFO - Downloading/unpacking functools32 (from jsonschema) 11:18:27 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 11:18:27 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 11:18:27 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 11:18:27 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 11:18:27 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 11:18:27 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 11:18:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:18:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:27 INFO - warning: no files found matching '*.txt' 11:18:27 INFO - no previously-included directories found matching 'build' 11:18:27 INFO - no previously-included directories found matching 'dist' 11:18:27 INFO - no previously-included directories found matching '.git*' 11:18:27 INFO - Installing collected packages: jsonschema, functools32 11:18:27 INFO - Running setup.py install for functools32 11:18:27 INFO - warning: no files found matching '*.txt' 11:18:27 INFO - no previously-included directories found matching 'build' 11:18:27 INFO - no previously-included directories found matching 'dist' 11:18:27 INFO - no previously-included directories found matching '.git*' 11:18:27 INFO - Successfully installed jsonschema functools32 11:18:27 INFO - Cleaning up... 11:18:27 INFO - Return code: 0 11:18:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47d4b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 11:18:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8'] in /builds/slave/test-pgo/build 11:18:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 flake8 11:18:27 INFO - Using env: {'DISPLAY': ':0', 11:18:27 INFO - 'HOME': '/home/cltbld', 11:18:27 INFO - 'LANG': 'en_US.UTF-8', 11:18:27 INFO - 'LANGUAGE': 'en_US:en', 11:18:27 INFO - 'LOGNAME': 'cltbld', 11:18:27 INFO - 'MAIL': '/var/mail/cltbld', 11:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:27 INFO - 'MOZ_NO_REMOTE': '1', 11:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:27 INFO - 'NO_EM_RESTART': '1', 11:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:27 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:27 INFO - 'SHELL': '/bin/bash', 11:18:27 INFO - 'SHLVL': '1', 11:18:27 INFO - 'TERM': 'linux', 11:18:27 INFO - 'TMOUT': '86400', 11:18:27 INFO - 'USER': 'cltbld', 11:18:27 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:27 INFO - '_': '/tools/buildbot/bin/python'} 11:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:28 INFO - Downloading/unpacking flake8 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:18:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 11:18:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:18:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:18:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 11:18:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:18:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:30 INFO - no previously-included directories found matching 'docs/_build' 11:18:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:18:30 INFO - Running setup.py install for pep8 11:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:30 INFO - no previously-included directories found matching 'docs/_build' 11:18:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:18:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:18:30 INFO - Cleaning up... 11:18:30 INFO - Return code: 0 11:18:30 INFO - Running post-action listener: _resource_record_post_action 11:18:30 INFO - Running post-action listener: _start_resource_monitoring 11:18:30 INFO - Starting resource monitoring. 11:18:30 INFO - ##### 11:18:30 INFO - ##### Running install step. 11:18:30 INFO - ##### 11:18:30 INFO - Running pre-action listener: _resource_record_pre_action 11:18:30 INFO - Running main action method: install 11:18:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:18:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:18:30 INFO - Reading from file tmpfile_stdout 11:18:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:18:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:18:31 INFO - Reading from file tmpfile_stdout 11:18:31 INFO - Output received: 11:18:31 INFO - Usage: mozinstall [options] installer 11:18:31 INFO - Options: 11:18:31 INFO - -h, --help show this help message and exit 11:18:31 INFO - -d DEST, --destination=DEST 11:18:31 INFO - Directory to install application into. [default: 11:18:31 INFO - "/builds/slave/test-pgo"] 11:18:31 INFO - --app=APP Application being installed. [default: firefox] 11:18:31 INFO - mkdir: /builds/slave/test-pgo/build/application 11:18:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:18:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:18:47 INFO - Reading from file tmpfile_stdout 11:18:47 INFO - Output received: 11:18:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:18:47 INFO - Running post-action listener: _resource_record_post_action 11:18:47 INFO - ##### 11:18:47 INFO - ##### Running run-tests step. 11:18:47 INFO - ##### 11:18:47 INFO - Running pre-action listener: _resource_record_pre_action 11:18:47 INFO - Running main action method: run_tests 11:18:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:18:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:18:47 INFO - Python 2.7.3 11:18:47 INFO - Return code: 0 11:18:47 INFO - grabbing minidump binary from tooltool 11:18: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')]} 11:18:47 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-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2840>, '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 0x2c5f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:18:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:18:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:18:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:47 INFO - Return code: 0 11:18:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:18:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:18:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:18:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:18:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:18:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:18:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:18:48 INFO - Return code: 0 11:18:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 11:18:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:18:48 INFO - Using env: {'DISPLAY': ':0', 11:18:48 INFO - 'HOME': '/home/cltbld', 11:18:48 INFO - 'LANG': 'en_US.UTF-8', 11:18:48 INFO - 'LANGUAGE': 'en_US:en', 11:18:48 INFO - 'LOGNAME': 'cltbld', 11:18:48 INFO - 'MAIL': '/var/mail/cltbld', 11:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:48 INFO - 'MOZ_NO_REMOTE': '1', 11:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:48 INFO - 'NO_EM_RESTART': '1', 11:18:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:48 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:18:48 INFO - 'SHELL': '/bin/bash', 11:18:48 INFO - 'SHLVL': '1', 11:18:48 INFO - 'TERM': 'linux', 11:18:48 INFO - 'TMOUT': '86400', 11:18:48 INFO - 'USER': 'cltbld', 11:18:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142', 11:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:48 INFO - '_': '/tools/buildbot/bin/python'} 11:18:48 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:18:48 INFO - mozversion application_buildid: 20160112083253 11:18:48 INFO - mozversion application_changeset: 98687c28986cb707736bd06d99366332b794b777 11:18:48 INFO - mozversion application_display_name: Nightly 11:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:48 INFO - mozversion application_name: Firefox 11:18:48 INFO - mozversion application_remotingname: firefox 11:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:18:48 INFO - mozversion application_vendor: Mozilla 11:18:48 INFO - mozversion application_version: 46.0a1 11:18:48 INFO - mozversion platform_buildid: 20160112083253 11:18:48 INFO - mozversion platform_changeset: 98687c28986cb707736bd06d99366332b794b777 11:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:18:48 INFO - mozversion platform_version: 46.0a1 11:18:48 INFO - using testdate: 1452626328 11:18:48 INFO - actual date: 1452626328 11:18:48 INFO - starting webserver on 'localhost:48734' 11:18:48 INFO - SUITE-START | Running 3 tests 11:18:48 INFO - TEST-START | dromaeo_css 11:18:48 INFO - operating with platform_type : linux_ 11:18:48 INFO - Initialising browser for dromaeo_css test... 11:18:48 INFO - TEST-INFO | started process 9053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplKK1zX/profile http://localhost:48734/getInfo.html) 11:18:52 INFO - PROCESS | 9053 | 11:18:52 INFO - PROCESS | 9053 | (process:9136): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:18:52 INFO - PROCESS | 9053 | __metrics Screen width/height:1600/1200 11:18:52 INFO - PROCESS | 9053 | colorDepth:24 11:18:52 INFO - PROCESS | 9053 | Browser inner width/height: 1024/697 11:18:52 INFO - PROCESS | 9053 | __metrics 11:18:53 INFO - PROCESS | 9053 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:18:53 INFO - TEST-INFO | 9053: exit 0 11:18:53 INFO - Browser initialized. 11:18:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:53 INFO - TEST-INFO | started process 9185 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplKK1zX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:55 INFO - PROCESS | 9185 | 11:18:55 INFO - PROCESS | 9185 | (process:9243): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:19:05 INFO - PROCESS | 9185 | RSS: Main: 150556672 11:19:05 INFO - PROCESS | 9185 | 11:19:55 INFO - PROCESS | 9185 | 1452626395341 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] 11:22:03 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:48734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48734/tests/dromaeo/cssquery-ext.html) 11:22:04 INFO - PROCESS | 9185 | RSS: Main: 155385856 11:22:04 INFO - PROCESS | 9185 | 11:25:06 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:48734/tests/dromaeo/cssquery-ext.html (next: http://localhost:48734/tests/dromaeo/cssquery-jquery.html) 11:25:07 INFO - PROCESS | 9185 | RSS: Main: 152612864 11:25:07 INFO - PROCESS | 9185 | 11:28:08 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:48734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48734/tests/dromaeo/cssquery-mootools.html) 11:28:09 INFO - PROCESS | 9185 | RSS: Main: 151052288 11:28:09 INFO - PROCESS | 9185 | 11:31:11 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:48734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48734/tests/dromaeo/cssquery-prototype.html) 11:31:11 INFO - PROCESS | 9185 | RSS: Main: 149651456 11:31:11 INFO - PROCESS | 9185 | 11:34:14 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:48734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48734/tests/dromaeo/cssquery-yui.html) 11:34:14 INFO - PROCESS | 9185 | RSS: Main: 151609344 11:34:14 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:48734/tests/dromaeo/cssquery-yui.html (next: http://localhost:48734/tests/dromaeo/cssquery-dojo.html) 11:37:17 INFO - PROCESS | 9185 | RSS: Main: 154054656 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | __start_tp_report 11:37:17 INFO - PROCESS | 9185 | _x_x_mozilla_page_load 11:37:17 INFO - PROCESS | 9185 | _x_x_mozilla_page_load_details 11:37:17 INFO - PROCESS | 9185 | |i|pagename|runs| 11:37:17 INFO - PROCESS | 9185 | |0;dojo.html;3160.4785210440277;3172.9682703172966;3188.52172174174;3208.43852325843;3210.0851257391646;5072.974635126824;5075.974620126899;5112.258722485238;5149.76826042828;5185.299984502091;5069.062223488657;5120.257562653423;5136.948630513693;5147.897042059157;5157.896842063156;4652.627789776827;4778.569928706415;4791.904161916759;4832.87917802056;4849.345338379327;688.8821239423327;4749.311349854269;4750.691205071676;4751.0972915146185;4776.259679749627;4417.359482874997;4717.882052948669;4736.881577960544;4790.484667366147;4792.856214313576;4778.593819525345;4782.569568738831;4806.4712881583;4839.322494850724;4842.806287748486;4585.495595484494;4829.637777166691;4829.758512074382;4834.323194752737;4844.442889067732;4959.727215003173;5024.673396229234;5029.17018691919;5053.090443720129;5069.543741063285;5407.134858422633;5426.864328391822;5432.13085906257;5440.4287549807495;5451.700156491392;5405.702686352249;5454.209139674725;5458.099413596752;5480.123180291174;5525.11598144299;5150.793968241303;5165.044466773659;5175.404828444739;5192.688438693653;5248.8687782805355;5540.501354878081;5580.776768929198;5609.214709940612;5621.7751289948765;5635.915461268084;5284.180951952453;5350.411454739976;5414.133738601883;5421.241026256327;5472.042392581282;5475.835724928259;5493.148561972821;5518.2826232590305;5520.558355331564;5561.77752889888;5355.866103347447;5359.5712343012465;5404.756785944642;5414.40441551429;5428.212909128233;5347.705876176848;5401.729913504388;5421.376541697677;5422.539084177889;5448.482394172547;4321.69748117635;4376.474823021258;4390.209762242827;4393.428854248928;4420.115976804587;3875.4961854958674;3911.3546264866545;3918.941215881764;3930.1746633206776;3942.9211415771524;5131.589472842164;5194.4026436959475;5221.034108689904;5228.816991405359;5246.921296180561;5402.837914862561;5590.385057643656;5628.465295796893;5631.2397826293745;5669.659820410789;5096.61775366849;5109.182530795055;5138.537531622097;5145.253938178943;5185.740712964337;4657.74382408964;4732.148213321635;4735.692180008288;4738.73936933465;4746.43042834862;5821.621594596338;5855.970720146457;5858;5870.26621672291;5907.852303692442;5418.295621569171;5462.508374246337;5466.262054622575;5470.53500452466;5481.698506582176;5631.63394379364;5647.322321321468;5678.2050512929045;5685;5754.19441278213;5433.402325744244;5477.4796394342475;5481.205225242397;5494.7802087917635;5539.086050801573;5439.891202175855;5479.123340265538;5485;5488.451154884479;5491.121420572689;5271.894562108813;5344.35867695879;5347.411784703757;5362.570994320367;5401.675899446046;5461.617686761889;5465.207544906046;5489.204065410573;5494.532964698045;5502.0371434997915;5338.946610533845;5385.515303622693;5386.946130538645;5404.459554044564;5435.130379139318;5340.866478338073;5385.461453854583;5401.729913504388;5482.506574408322;5483.396826349019;5260.263563101093;5282.445343238905;5287.68273903567;5290.629655924048;5296.443873393392 11:37:17 INFO - PROCESS | 9185 | |1;ext.html;525.3879230696239;570.4951118260338;581.5347721822541;583.5506659871899;593.382881802925;34104.4884326735;34522;34719;34788.652113478856;34981.12547186322;37966;38184.04539886504;38392.42411363832;38437.80781096098;38733.806330968306;8313.127121652231;8521.233089021987;8531.744047678549;8561.914380856175;8577.742667719947;8248.670053197864;8428.53643049632;8438.029626592928;8536.957315213414;8580.656773729042;8568.571571421435;8631.69789057383;8674.479531228146;8676;8695.39132260742;8543.914560854406;8602.612882420306;8612.483251004896;8620.224179823846;8646.61090250937;8464.915350846475;8532.658693652247;8563;8569.785755356104;8586.055533891267;35123.473147902805;35368.646313536796;35501.46747798759;35530.64469355325;35613.82193089018;2924.1227631710403;2973.5688325192727;2982.597349357852;3077.3845230953675;3341.9498707519406;27975.22334484839;29167.85416072906;29312.413751724845;29324.853375733197;30429.847850760605;3109.4247564200696;3124.562561241428;3136.8588413521447;3157.747380209578;3169.8732050717945;315290;317174;319442;319814;320099.1985120225;40296.798516007235;40760.59239407627;53897.730511347974;54269.1859622106;54343.45656543384;38629;38739;38769;38782.612173878464;39206.21587568233;13300.600981970556;13491.797623035662;13518.662033449045;13519.594412167651;13543.796843047363;11006.229563930608;11025.117990560897;11117.888821111846;11127.165462590337;11158.944205278922;13458.865411345958;13530.864691353157;13825.170489770646;13928.442862285396;14004.85995140056;5596.664200148004;5681.886362272731;5689.687067211343;5763.135529670583;5785;916.867054277126;988.9851652225223;1006.993006993007;1045.9529321180564;1046.6441409920662;27440.313992150357;27960.72039279622;28001.439971200463;28101.297467563476;28235;971.577363846729;980.8038392321564;981.9754506137403;1021.6168936648756;1049.4280617063719;13349.998750093782;15946.36214551405;16148.75776863348;16227.188640567925;16410;394778;395282;395969;396112;396744;50621.240681389805;50814.23778643323;51078.14757598022;51329.48670513322;51771;1302.1210682789078;1309.8493673227701;1319.300770591588;1324.0334555774145;1327.575175943708;27698.169054928385;29004.419911601228;29170.854145729136;29201.85399072991;29331;42386.57613423826;42759.93100172396;42983.140337193705;43084.569154308054;43556;297767;297852;299211;299211;299668;30378.544321834746;39097.21805563816;39110.41334379929;41085;41421;35899.82050089733;36251.63748362483;36265.27469450649;37543;38004.42993355047;31866.840665796524;32500.34999300048;32658.34683306273;32998.34003319872;33025;33054;36979.63020369762;37922;38323.425148622235;38536.80731596324;32221.51667724939;32253.35493290168;32296.677033229367;35361.46957795584;36225.27549449049;27977.44045119127;29408.26479338034;29580.852095739385;29678.851605742697;29832.403351932404;22640.773592263868;23334.649980250648;23809.285721427692;23916.52166956686;23918.52162956766 11:37:17 INFO - PROCESS | 9185 | |2;jquery.html;355.848764275183;359.39800833603715;359.8614533404639;361.33514333626124;361.3838405518591;15700.450484233053;16137.515874523768;16329.34682612694;17063.40278090267;17165.914170429147;9531;9707.174890134347;13876.79184812226;15937;15961.361545538193;4772.093302272575;4793.856184314476;4841.128596852565;4845.515448455161;4857.494176805184;4754.453237877637;4779.474257831635;4790.640701947351;4813.831515896944;4865.172920603488;4677.13473007493;4917.680350777206;6096.116063170837;6355.2373715154245;6365.52258580606;6450.8064758057335;6479.35206479353;6495.155629768124;6803.421709154728;6844.828879278008;6345.904811427832;6543.836404089889;6577.24361698406;6586.571872828251;6655.46756259498;20420.489487762778;20890.059947302256;21210.151593936225;21284.680729789066;22160.667589986002;2083.3020937985793;2176;2231.252530402317;2350.6826578412038;2355.340504658698;7877;13361.66595835102;13521;13872.861246409391;13963.650908727363;1939.156466936887;1944.4166749974952;1948.230448972662;1974.0919177178514;1997.4107638246608;64599.354006459806;66005.66997165032;66798.66600667014;67285.6635716828;68138.31861681418;14347.78478322826;14702.485413010494;14725.821934245234;14747.18890461035;14757.483488077865;22611;22731.88634056819;22806.65790013151;22873.771262287497;22873.885630572073;8516.914830851736;8544.658213671384;8751.868721969175;8810.251128654008;8860.512671803113;7287.052683151156;7326.93759404894;7461.813454663568;7565.6217189140325;7599.582022988789;7319.34125928669;7362.337389634851;7369.742059027908;7399.519031263058;7401.48189626721;1663.6672665466713;1749.1691446562781;1771.5305444057335;2918.64976202857;3035.6964303569466;828;867.111211008721;946.6781294359951;962.0667952086465;1044.4072788996841;15721.606959826096;15805.209739512979;16059.598510037109;16389.262483188286;16710.24803883804;925.1303774451993;925.9166674999283;945.3854994253653;973.153356579766;995.6913356859396;9100.226480749077;9244.722658320126;9484.715458536255;9580.904190958141;9674;510111;514619;521648;569348;570031;70380.59238815196;71177;72738;73847;74159.62920185365;1105.8507101541188;1124.6457365929707;1134.869490008643;1134.8865113488584;1151.7984352738238;14914.776278355615;14930.477433289783;14992.700145997238;15047.699046019237;15074.321655525308;30083.94706185273;30130.84934575313;30259.546106808855;30486.847565762917;32159.67840321567;39359.40960885646;39470.40794388029;39675.40486892641;40624.79687601543;41095.1780964373;6977.441804655514;7052.153741551047;7052.788416347517;7305.1599066105955;7424.814379640552;10461.843072353768;10634.468276586294;10863.837042444527;11297.71755706114;11590.246633969102;8787.165219304155;9251.722448326562;9690.806183876424;9770.413775173512;9976.25178111659;9389.201917837061;9391.530423478662;9508.049195080437;9728.17310528613;9863.457509837028;9529.618815247313;9643.662471813454;9692.176165026052;9768.609255629695;9798.559064841957;6732.8653426930205;6826.761063362758;6867.553609015398;6892.793216203522;7047.119110111236;8362.331013518782;9701.902980970382;9949;10101.949490252502;10179.134773544036 11:37:17 INFO - PROCESS | 9185 | |3;mootools.html;1439.1365180891466;1449.1812126148725;1571.4521196621326;1725.567778743643;1734.3582874336505;7700.768976930687;7709.498882572629;7883.132855385903;7918.485298455604;7920.247576480232;7720.0735911690535;7760.223977602237;7762.883556746653;7819.452638315321;7843.450958432912;2261.1520679745136;2283.5318759654315;2290.0725206291395;2290.770922907704;2291.0263138166297;2261.389424855288;2294.380517260339;2328.371339738278;2329.3827135809024;2331.114176612885;2212.3473575295325;2257.2551058150852;2264.8188144948363;2278.3506700590333;2289.0157232390147;2249.190291495069;2258.9435264118447;2266.818654507652;2275.5448910218024;2283.4748007958096;2239.193890199543;2253.9774602253933;2259.2883241778786;2263.128695452246;2264.9660255096187;7625.656845441913;7628.847423051508;7635.618219089023;7690.769276921701;7699.153093159748;4542.227821270392;4641.257398816173;4644.9535504644855;4652.55800698933;4666.416697912761;2800.341919648881;2829.688734239232;2894.9710502894914;2902.4195160967893;2907.1569244918946;949.4113649537331;983.896690847465;991.8264303746888;1008.2438171371472;1056.4717641179411;10473.790524189473;10596.152307815357;10624.575016999312;10633.680989570325;10752.78494430115;4062.878113656595;4071.1247081877536;4145.17096580685;4154.91690166195;4165.354370072643;8540.829183416297;8576.614052367659;8596.097409772008;8599.441036332619;8617.138286171332;4627.259638457831;4635.490096089427;4636.2581986882615;4655.697379670379;4660.161170989254;4281.293586558245;4291.098869237495;4301.806418711166;4308.310670292738;4322.5519450984275;3318.203631128512;3356.56364672591;3356.664333566624;3359.5800524934384;3380.2901390707734;1012.8987101289812;1023.81059503992;1023.8976102389702;1025.3489034463169;1035.8342665173536;943.056943056943;948.0898337595847;1020.3418794877263;1068.5351871935577;1252.6054292897709;6905.37851593359;6926.549774264657;6929.896051559231;6977.965110174417;6989.4408447324095;1086.179934149712;1100.6037826382496;1104.447776111944;1123.8988491035846;1138.8576427946507;5532.280803495601;5561.6663000220115;5562.610617256834;5628.746706398222;5633.183188437653;9174.128457796498;9204.953975230215;9554.044595540528;9618.086281803218;9714.368566043184;9458.85811712825;9464.432134071978;9484.478353690476;9486.383385079947;9494.192993595483;7249.202587715347;7424.888626670496;7469.327760501581;7484.775456736306;7574.545527268271;7018.403435708022;7028.753993610199;7066.763316419709;7115.288471152843;7145.21402645719;8220.3834712398;8228.341732661253;8535.402521823413;8535.487870727777;8609.268212201783;8656.177663121993;8701.738947831574;8774.736757897273;8786.868196977179;8809.075047120217;6584.736610535525;6759.628220447923;6793.388595026471;6797.89803152963;6823.249442561413;7241.565506069653;7282.563046217244;7292.635368231673;7297.489175757858;7304.8539029218055;6826.931730682828;6986.860262794818;7113.253108423541;7121.572705637678;7175;6120.1125836752535;6495.805125846232;6807.21717002551;6848.7260509579055;6903.206131294965;6953.6523173842115;6963.268856769966;6974.895376569457;6996.300369962963;7002.684879180551;6320.841978950563;6321.905171422341;6369.936300636934;6373.075903993988;6380.776672816429;6385.425311721968;6426.100345951477;6456.12842266288;6463.353664633499;6486.4486518646445 11:37:17 INFO - PROCESS | 9185 | |4;prototype.html;327.60196361420867;328.08464384367613;332.5992179423795;333.9165208697824;334.9430596798544;6178.752849886005;6184.443400093991;6214.596051256671;6269.905951410732;6431.646259455728;6122.724477398517;6213.533984951124;6224.751009959597;6235.532335074876;6238.781642642497;4779.976100119512;4786.449558300805;4789.305550695164;4792.520747925197;4799.736014519218;4753.595944344717;4783.760811959405;4795.736234507101;4795.784189711471;4802.5197480252045;4668.25307950728;4713.34013238147;4719.669623126382;4724.90550188996;4737.336772851803;4727.810887564493;4733.739644319561;4736.029114031632;4739.7630118493935;4742.2886567014875;4105.67154627632;4111.568285330057;4111.938320925188;4123.958760412387;4133.379993001044;5914.763409463616;5920.703964801743;5923.5853490255695;5924.437178468082;5933.525317974551;5406.378266499363;5509.090999984997;5511.338639363302;5516.475934786189;5524.889502209973;6569.671516424208;6587.637679927602;6603.867922641568;6606.339366063403;6610.8016759497295;4561.543845615445;4578.153041687298;4585.656075794329;4585.885352866172;4589.862304130881;6725.630090345029;6788.76239331621;6876.415504682108;6880.139982502187;6896.482763792736;4626.467956185082;4635.443746750344;4646.697964632288;4652.744099074584;4655.138799322136;4679.532046795293;4702.6708130431225;4705.811767529261;4711.128441238313;4712.88217794551;5437.619366644376;5440.966216418868;5445.673259604437;5449.01917654826;5453.4273901240595;6539.182602174728;6591.670416479157;6630.138082049302;6638.7676431325635;6641.767538136142;1613.6691978144452;1638.9262483188286;1653.4047742812577;1655.6771429571359;1659.2284587666793;1082.334364365925;1099.3458891959272;1099.378850949211;1100.862392200975;1110.4669758515959;6171.814845554641;6181.114759998244;6186.752529898844;6218.440340369298;6232.189815323979;6661.067450556926;6664.633445160466;6720.1599800025;6731.697073631698;6737.157855268091;6070.3019152798;6198.2252218472695;6205.317415084337;6214.378562143749;6222.346653601307;3654.068212605822;3673.1368128489785;3675.6691897729334;3676.761010534307;3681.3557627415094;7086.4685148613025;7089.7873063808165;7090.432765378758;7094.361507464249;7102.254263302382;6691.866162676719;6831.726730930707;6877.4841886858685;6879.140107486564;6898.7240510380025;7038.859222815618;7056.223815380304;7077.327653872874;7088.716451341888;7096.92903070973;6667.599944003376;6680.799576012728;6692.665366731741;6701.296363881722;6723.462123030244;6521.771737989147;6607.834804129935;6637.037629543593;6642.3025582315095;6645.534812563074;7031.824204394931;7054.365107140382;7058.647067646494;7064.434845212473;7072.186698529735;4621.3530105785885;4632;4639.188142075056;4643.976780116213;4647.442306923191;6677.031830384664;6691.263960964193;6696.363845434676;6710;6865.519413640997;6651.268360480247;6669.4664426844765;6670.966645166937;6687.164104486939;6703.798886033232;6637.336266373324;6638.900416493853;6651.73393064272;6665.133532640726;6689.063531105747;6460.25707043696;6551.44312733404;6555.770548030796;6574.342565743387;6583.473322134122;6672.599644021374;6695.7321707133115;6728.293529179561;6732.495062870402;6738.797836064926;6498.415142637185;6507.446867016357;6516.218053833571;6548.148740663683;6562.179727534059 11:37:17 INFO - PROCESS | 9185 | |5;yui.html;633.1990032608747;634.3086036220519;675.6013951768457;690.7064497588524;776.0338378718495;13253.668658283535;13328.600141995732;13363.398647060882;13437.865621343795;15063.322150503227;13707;13823.170609763421;13840.653983650414;13878.514252001181;13916.373763180656;765.0360545712415;768.1358471719329;773.342658740072;776.7825008997462;780.2938340801584;775.1008829757483;776.0997243197892;776.9300762931335;777.3547955197173;779.6374685771116;800.6917336825306;810.1979040749645;810.7040930060515;812.102626597607;813.1055838577577;799.6001999000529;799.7200979657132;800.415696541525;800.9799755006143;809.5749731391008;595.9702014899237;598.1327075740151;599.8530360061769;601.0653433910268;601.6029420582438;12843.614691559269;12908.290044047573;12913.548025819051;12980.805287920593;13032.609021729364;11688.240264382874;12001.459934302977;12074.637760867101;12192.634220973385;12329.445174967148;9359.618194603028;9598.328117031811;9616.23070154386;9713.174380177623;9961.103500684972;3261.1031966209243;3288.720458761008;3311.4536101543217;3391.542141810873;3427.2974040321924;47053.52946470526;47596;47667.76166119182;47905.520944790806;48187.518124819006;8749.931881121414;8797.824043519095;9145.90854091464;9225.630974761069;9382.5308734563;16947.237374318185;17130.828691713174;17164.227609757592;17212.569685757957;17218.483445496655;6721.462283017347;6726.125603671491;6753.831154221086;6782.830429239309;7061.540999834994;3917.8236979335998;3946.131850992777;4033.3748269018347;4085.2442298174933;4117.91764164715;2912.039027121045;2915.3149009982635;2943.058221369184;2949.8230106193696;2953.896613618556;522.7699812082672;544.0940833512158;554.2628304355198;570.5606682854179;570.8515785895697;470.87757183132635;538.7252501224325;585.7978997245943;591.819495054004;608.4767100293744;7827.412944029106;7999.480033797785;8085.959570202229;8172.7956801080445;8211.753647390588;517.1957605922826;541.769747857167;555.4639772619441;618.2241287184554;645.1806206118204;3787.280416720814;3850.1914597934187;3879.6702280305926;3984.7609143450904;4128.153728485653;49687.50312496829;49893;49998.500015000114;57724;59053.70473147607;46162.769186154525;46240;46244.76877615591;46351.76824115858;48517.75741121272;45131.32303015458;45251;45629.31556026596;47090.5290947093;47253;8285.751427457186;8350.916490835014;8458.984921809422;8464.70373536948;8642.697505587274;33913.66086339105;34691.653083468846;34808.65191348054;35194;35965.280694385445;42411.787941060094;44127.77936110427;44701.32948005848;44730;44948.77525612351;10376.377417354983;10414.323069000491;10531.104856087319;10835.317234449818;10908.127349812155;10093.041161089684;10181.269184238845;10277.588896444058;10379.844302335621;10939.945300273766;10204.693859183939;10429.791404171723;10431.269811113149;10703.357798532114;10781.137508999105;10022.749431264278;10121.481658358694;10149.34029288094;10193;10404.791904161722;10363.963603639575;10756.408397538211;10817.945910270713;10892.945535272273;10907.647657083196;8611.5494317871;8617.913820861711;8629.741107766777;8711.738647840575;8980.416272942239;8406.327493800603;8716.302695784196;9267.67563135287;9272.675456358995;9306.221993099958 11:37:17 INFO - PROCESS | 9185 | __end_tp_report 11:37:17 INFO - PROCESS | 9185 | __start_cc_report 11:37:17 INFO - PROCESS | 9185 | _x_x_mozilla_cycle_collect,304 11:37:17 INFO - PROCESS | 9185 | __end_cc_report 11:37:17 INFO - PROCESS | 9185 | __startTimestamp1452627437622__endTimestamp 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | ------- Summary: start ------- 11:37:17 INFO - PROCESS | 9185 | Number of tests: 6 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | [#0] dojo.html Cycles:165 Average:5111.57 Median:5340.87 stddev:633.85 (11.9%) stddev-sans-first:617.04 11:37:17 INFO - PROCESS | 9185 | Values: 3160.5 3173.0 3188.5 3208.4 3210.1 5073.0 5076.0 5112.3 5149.8 5185.3 5069.1 5120.3 5136.9 5147.9 5157.9 4652.6 4778.6 4791.9 4832.9 4849.3 688.9 4749.3 4750.7 4751.1 4776.3 4417.4 4717.9 4736.9 4790.5 4792.9 4778.6 4782.6 4806.5 4839.3 4842.8 4585.5 4829.6 4829.8 4834.3 4844.4 4959.7 5024.7 5029.2 5053.1 5069.5 5407.1 5426.9 5432.1 5440.4 5451.7 5405.7 5454.2 5458.1 5480.1 5525.1 5150.8 5165.0 5175.4 5192.7 5248.9 5540.5 5580.8 5609.2 5621.8 5635.9 5284.2 5350.4 5414.1 5421.2 5472.0 5475.8 5493.1 5518.3 5520.6 5561.8 5355.9 5359.6 5404.8 5414.4 5428.2 5347.7 5401.7 5421.4 5422.5 5448.5 4321.7 4376.5 4390.2 4393.4 4420.1 3875.5 3911.4 3918.9 3930.2 3942.9 5131.6 5194.4 5221.0 5228.8 5246.9 5402.8 5590.4 5628.5 5631.2 5669.7 5096.6 5109.2 5138.5 5145.3 5185.7 4657.7 4732.1 4735.7 4738.7 4746.4 5821.6 5856.0 5858.0 5870.3 5907.9 5418.3 5462.5 5466.3 5470.5 5481.7 5631.6 5647.3 5678.2 5685.0 5754.2 5433.4 5477.5 5481.2 5494.8 5539.1 5439.9 5479.1 5485.0 5488.5 5491.1 5271.9 5344.4 5347.4 5362.6 5401.7 5461.6 5465.2 5489.2 5494.5 5502.0 5338.9 5385.5 5386.9 5404.5 5435.1 5340.9 5385.5 5401.7 5482.5 5483.4 5260.3 5282.4 5287.7 5290.6 5296.4 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | [#1] ext.html Cycles:180 Average:48125.11 Median:35242.47 stddev:89633.54 (254.3%) stddev-sans-first:89813.74 11:37:17 INFO - PROCESS | 9185 | Values: 525.4 570.5 581.5 583.6 593.4 34104.5 34522.0 34719.0 34788.7 34981.1 37966.0 38184.0 38392.4 38437.8 38733.8 8313.1 8521.2 8531.7 8561.9 8577.7 8248.7 8428.5 8438.0 8537.0 8580.7 8568.6 8631.7 8674.5 8676.0 8695.4 8543.9 8602.6 8612.5 8620.2 8646.6 8464.9 8532.7 8563.0 8569.8 8586.1 35123.5 35368.6 35501.5 35530.6 35613.8 2924.1 2973.6 2982.6 3077.4 3341.9 27975.2 29167.9 29312.4 29324.9 30429.8 3109.4 3124.6 3136.9 3157.7 3169.9 315290.0 317174.0 319442.0 319814.0 320099.2 40296.8 40760.6 53897.7 54269.2 54343.5 38629.0 38739.0 38769.0 38782.6 39206.2 13300.6 13491.8 13518.7 13519.6 13543.8 11006.2 11025.1 11117.9 11127.2 11158.9 13458.9 13530.9 13825.2 13928.4 14004.9 5596.7 5681.9 5689.7 5763.1 5785.0 916.9 989.0 1007.0 1046.0 1046.6 27440.3 27960.7 28001.4 28101.3 28235.0 971.6 980.8 982.0 1021.6 1049.4 13350.0 15946.4 16148.8 16227.2 16410.0 394778.0 395282.0 395969.0 396112.0 396744.0 50621.2 50814.2 51078.1 51329.5 51771.0 1302.1 1309.8 1319.3 1324.0 1327.6 27698.2 29004.4 29170.9 29201.9 29331.0 42386.6 42759.9 42983.1 43084.6 43556.0 297767.0 297852.0 299211.0 299211.0 299668.0 30378.5 39097.2 39110.4 41085.0 41421.0 35899.8 36251.6 36265.3 37543.0 38004.4 31866.8 32500.3 32658.3 32998.3 33025.0 33054.0 36979.6 37922.0 38323.4 38536.8 32221.5 32253.4 32296.7 35361.5 36225.3 27977.4 29408.3 29580.9 29678.9 29832.4 22640.8 23334.6 23809.3 23916.5 23918.5 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | [#2] jquery.html Cycles:180 Average:28145.07 Median:4891.43 stddev:87849.44 (1796.0%) stddev-sans-first:88071.09 11:37:17 INFO - PROCESS | 9185 | Values: 355.8 359.4 359.9 361.3 361.4 15700.5 16137.5 16329.3 17063.4 17165.9 9531.0 9707.2 13876.8 15937.0 15961.4 4772.1 4793.9 4841.1 4845.5 4857.5 4754.5 4779.5 4790.6 4813.8 4865.2 4677.1 4917.7 6096.1 6355.2 6365.5 6450.8 6479.4 6495.2 6803.4 6844.8 6345.9 6543.8 6577.2 6586.6 6655.5 20420.5 20890.1 21210.2 21284.7 22160.7 2083.3 2176.0 2231.3 2350.7 2355.3 7877.0 13361.7 13521.0 13872.9 13963.7 1939.2 1944.4 1948.2 1974.1 1997.4 64599.4 66005.7 66798.7 67285.7 68138.3 14347.8 14702.5 14725.8 14747.2 14757.5 22611.0 22731.9 22806.7 22873.8 22873.9 8516.9 8544.7 8751.9 8810.3 8860.5 7287.1 7326.9 7461.8 7565.6 7599.6 7319.3 7362.3 7369.7 7399.5 7401.5 1663.7 1749.2 1771.5 2918.6 3035.7 828.0 867.1 946.7 962.1 1044.4 15721.6 15805.2 16059.6 16389.3 16710.2 925.1 925.9 945.4 973.2 995.7 9100.2 9244.7 9484.7 9580.9 9674.0 510111.0 514619.0 521648.0 569348.0 570031.0 70380.6 71177.0 72738.0 73847.0 74159.6 1105.9 1124.6 1134.9 1134.9 1151.8 14914.8 14930.5 14992.7 15047.7 15074.3 30083.9 30130.8 30259.5 30486.8 32159.7 39359.4 39470.4 39675.4 40624.8 41095.2 6977.4 7052.2 7052.8 7305.2 7424.8 10461.8 10634.5 10863.8 11297.7 11590.2 8787.2 9251.7 9690.8 9770.4 9976.3 9389.2 9391.5 9508.0 9728.2 9863.5 9529.6 9643.7 9692.2 9768.6 9798.6 6732.9 6826.8 6867.6 6892.8 7047.1 8362.3 9701.9 9949.0 10101.9 10179.1 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | [#3] mootools.html Cycles:180 Average:5393.25 Median:6383.10 stddev:2821.73 (44.2%) stddev-sans-first:2813.99 11:37:17 INFO - PROCESS | 9185 | Values: 1439.1 1449.2 1571.5 1725.6 1734.4 7700.8 7709.5 7883.1 7918.5 7920.2 7720.1 7760.2 7762.9 7819.5 7843.5 2261.2 2283.5 2290.1 2290.8 2291.0 2261.4 2294.4 2328.4 2329.4 2331.1 2212.3 2257.3 2264.8 2278.4 2289.0 2249.2 2258.9 2266.8 2275.5 2283.5 2239.2 2254.0 2259.3 2263.1 2265.0 7625.7 7628.8 7635.6 7690.8 7699.2 4542.2 4641.3 4645.0 4652.6 4666.4 2800.3 2829.7 2895.0 2902.4 2907.2 949.4 983.9 991.8 1008.2 1056.5 10473.8 10596.2 10624.6 10633.7 10752.8 4062.9 4071.1 4145.2 4154.9 4165.4 8540.8 8576.6 8596.1 8599.4 8617.1 4627.3 4635.5 4636.3 4655.7 4660.2 4281.3 4291.1 4301.8 4308.3 4322.6 3318.2 3356.6 3356.7 3359.6 3380.3 1012.9 1023.8 1023.9 1025.3 1035.8 943.1 948.1 1020.3 1068.5 1252.6 6905.4 6926.5 6929.9 6978.0 6989.4 1086.2 1100.6 1104.4 1123.9 1138.9 5532.3 5561.7 5562.6 5628.7 5633.2 9174.1 9205.0 9554.0 9618.1 9714.4 9458.9 9464.4 9484.5 9486.4 9494.2 7249.2 7424.9 7469.3 7484.8 7574.5 7018.4 7028.8 7066.8 7115.3 7145.2 8220.4 8228.3 8535.4 8535.5 8609.3 8656.2 8701.7 8774.7 8786.9 8809.1 6584.7 6759.6 6793.4 6797.9 6823.2 7241.6 7282.6 7292.6 7297.5 7304.9 6826.9 6986.9 7113.3 7121.6 7175.0 6120.1 6495.8 6807.2 6848.7 6903.2 6953.7 6963.3 6974.9 6996.3 7002.7 6320.8 6321.9 6369.9 6373.1 6380.8 6385.4 6426.1 6456.1 6463.4 6486.4 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | [#4] prototype.html Cycles:180 Average:5502.87 Median:6214.49 stddev:1663.01 (26.8%) stddev-sans-first:1621.67 11:37:17 INFO - PROCESS | 9185 | Values: 327.6 328.1 332.6 333.9 334.9 6178.8 6184.4 6214.6 6269.9 6431.6 6122.7 6213.5 6224.8 6235.5 6238.8 4780.0 4786.4 4789.3 4792.5 4799.7 4753.6 4783.8 4795.7 4795.8 4802.5 4668.3 4713.3 4719.7 4724.9 4737.3 4727.8 4733.7 4736.0 4739.8 4742.3 4105.7 4111.6 4111.9 4124.0 4133.4 5914.8 5920.7 5923.6 5924.4 5933.5 5406.4 5509.1 5511.3 5516.5 5524.9 6569.7 6587.6 6603.9 6606.3 6610.8 4561.5 4578.2 4585.7 4585.9 4589.9 6725.6 6788.8 6876.4 6880.1 6896.5 4626.5 4635.4 4646.7 4652.7 4655.1 4679.5 4702.7 4705.8 4711.1 4712.9 5437.6 5441.0 5445.7 5449.0 5453.4 6539.2 6591.7 6630.1 6638.8 6641.8 1613.7 1638.9 1653.4 1655.7 1659.2 1082.3 1099.3 1099.4 1100.9 1110.5 6171.8 6181.1 6186.8 6218.4 6232.2 6661.1 6664.6 6720.2 6731.7 6737.2 6070.3 6198.2 6205.3 6214.4 6222.3 3654.1 3673.1 3675.7 3676.8 3681.4 7086.5 7089.8 7090.4 7094.4 7102.3 6691.9 6831.7 6877.5 6879.1 6898.7 7038.9 7056.2 7077.3 7088.7 7096.9 6667.6 6680.8 6692.7 6701.3 6723.5 6521.8 6607.8 6637.0 6642.3 6645.5 7031.8 7054.4 7058.6 7064.4 7072.2 4621.4 4632.0 4639.2 4644.0 4647.4 6677.0 6691.3 6696.4 6710.0 6865.5 6651.3 6669.5 6671.0 6687.2 6703.8 6637.3 6638.9 6651.7 6665.1 6689.1 6460.3 6551.4 6555.8 6574.3 6583.5 6672.6 6695.7 6728.3 6732.5 6738.8 6498.4 6507.4 6516.2 6548.1 6562.2 11:37:17 INFO - PROCESS | 9185 | 11:37:17 INFO - PROCESS | 9185 | [#5] yui.html Cycles:180 Average:13193.62 Median:47424.50 stddev:15360.41 (32.4%) stddev-sans-first:15374.54 11:37:17 INFO - PROCESS | 9185 | Values: 633.2 634.3 675.6 690.7 776.0 13253.7 13328.6 13363.4 13437.9 15063.3 13707.0 13823.2 13840.7 13878.5 13916.4 765.0 768.1 773.3 776.8 780.3 775.1 776.1 776.9 777.4 779.6 800.7 810.2 810.7 812.1 813.1 799.6 799.7 800.4 801.0 809.6 596.0 598.1 599.9 601.1 601.6 12843.6 12908.3 12913.5 12980.8 13032.6 11688.2 12001.5 12074.6 12192.6 12329.4 9359.6 9598.3 9616.2 9713.2 9961.1 3261.1 3288.7 3311.5 3391.5 3427.3 47053.5 47596.0 47667.8 47905.5 48187.5 8749.9 8797.8 9145.9 9225.6 9382.5 16947.2 17130.8 17164.2 17212.6 17218.5 6721.5 6726.1 6753.8 6782.8 7061.5 3917.8 3946.1 4033.4 4085.2 4117.9 2912.0 2915.3 2943.1 2949.8 2953.9 522.8 544.1 554.3 570.6 570.9 470.9 538.7 585.8 591.8 608.5 7827.4 7999.5 8086.0 8172.8 8211.8 517.2 541.8 555.5 618.2 645.2 3787.3 3850.2 3879.7 3984.8 4128.2 49687.5 49893.0 49998.5 57724.0 59053.7 46162.8 46240.0 46244.8 46351.8 48517.8 45131.3 45251.0 45629.3 47090.5 47253.0 8285.8 8350.9 8459.0 8464.7 8642.7 33913.7 34691.7 34808.7 35194.0 35965.3 42411.8 44127.8 44701.3 44730.0 44948.8 10376.4 10414.3 10531.1 10835.3 10908.1 10093.0 10181.3 10277.6 10379.8 10939.9 10204.7 10429.8 10431.3 10703.4 10781.1 10022.7 10121.5 10149.3 10193.0 10404.8 10364.0 10756.4 10817.9 10892.9 10907.6 8611.5 8617.9 8629.7 8711.7 8980.4 8406.3 8716.3 9267.7 9272.7 9306.2 11:37:17 INFO - PROCESS | 9185 | -------- Summary: end -------- 11:37:17 INFO - PROCESS | 9185 | 11:37:18 INFO - TEST-INFO | 9185: exit 0 11:37:18 INFO - TEST-OK | dromaeo_css | took 1110004ms 11:37:18 INFO - TEST-START | kraken 11:37:18 INFO - operating with platform_type : linux_ 11:37:18 INFO - Initialising browser for kraken test... 11:37:18 INFO - TEST-INFO | started process 9419 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnmit2A/profile http://localhost:48734/getInfo.html) 11:37:21 INFO - PROCESS | 9419 | 11:37:21 INFO - PROCESS | 9419 | (process:9493): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:37:22 INFO - PROCESS | 9419 | __metrics Screen width/height:1600/1200 11:37:22 INFO - PROCESS | 9419 | colorDepth:24 11:37:22 INFO - PROCESS | 9419 | Browser inner width/height: 1024/697 11:37:22 INFO - PROCESS | 9419 | __metrics 11:37:22 INFO - PROCESS | 9419 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:37:23 INFO - TEST-INFO | 9419: exit 0 11:37:23 INFO - Browser initialized. 11:37:23 INFO - Running cycle 1/1 for kraken test... 11:37:23 INFO - TEST-INFO | started process 9542 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnmit2A/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:24 INFO - PROCESS | 9542 | 11:37:24 INFO - PROCESS | 9542 | (process:9603): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:37:35 INFO - PROCESS | 9542 | RSS: Main: 150405120 11:37:35 INFO - PROCESS | 9542 | 11:37:37 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48734/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:38 INFO - PROCESS | 9542 | RSS: Main: 151683072 11:37:38 INFO - PROCESS | 9542 | 11:37:41 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48734/tests/kraken/driver.html?testName=audio-dft) 11:37:41 INFO - PROCESS | 9542 | RSS: Main: 150740992 11:37:41 INFO - PROCESS | 9542 | 11:37:44 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48734/tests/kraken/driver.html?testName=audio-fft) 11:37:45 INFO - PROCESS | 9542 | RSS: Main: 146698240 11:37:45 INFO - PROCESS | 9542 | 11:37:47 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48734/tests/kraken/driver.html?testName=audio-oscillator) 11:37:48 INFO - PROCESS | 9542 | RSS: Main: 145788928 11:37:48 INFO - PROCESS | 9542 | 11:37:50 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:51 INFO - PROCESS | 9542 | RSS: Main: 146776064 11:37:51 INFO - PROCESS | 9542 | 11:37:53 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48734/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:54 INFO - PROCESS | 9542 | RSS: Main: 145588224 11:37:54 INFO - PROCESS | 9542 | 11:37:57 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48734/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:58 INFO - PROCESS | 9542 | RSS: Main: 147472384 11:37:58 INFO - PROCESS | 9542 | 11:38:01 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48734/tests/kraken/driver.html?testName=json-parse-financial) 11:38:01 INFO - PROCESS | 9542 | RSS: Main: 147714048 11:38:01 INFO - PROCESS | 9542 | 11:38:03 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:04 INFO - PROCESS | 9542 | RSS: Main: 148627456 11:38:04 INFO - PROCESS | 9542 | 11:38:05 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:06 INFO - PROCESS | 9542 | RSS: Main: 147365888 11:38:06 INFO - PROCESS | 9542 | 11:38:08 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:09 INFO - PROCESS | 9542 | RSS: Main: 147779584 11:38:09 INFO - PROCESS | 9542 | 11:38:11 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:12 INFO - PROCESS | 9542 | RSS: Main: 147652608 11:38:12 INFO - PROCESS | 9542 | 11:38:14 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:15 INFO - PROCESS | 9542 | RSS: Main: 149250048 11:38:15 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | Cycle 1(1): loaded http://localhost:48734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48734/tests/kraken/driver.html?testName=ai-astar) 11:38:17 INFO - PROCESS | 9542 | RSS: Main: 149536768 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | __start_tp_report 11:38:17 INFO - PROCESS | 9542 | _x_x_mozilla_page_load 11:38:17 INFO - PROCESS | 9542 | _x_x_mozilla_page_load_details 11:38:17 INFO - PROCESS | 9542 | |i|pagename|runs| 11:38:17 INFO - PROCESS | 9542 | |0;ai-astar;112;109;113;112;112;123;111;112;113;112 11:38:17 INFO - PROCESS | 9542 | |1;audio-beat-detection;157;127;152;165;127;149;162;129;167;127 11:38:17 INFO - PROCESS | 9542 | |2;audio-dft;162;163;161;165;162;161;162;164;167;161 11:38:17 INFO - PROCESS | 9542 | |3;audio-fft;72;75;75;72;74;72;73;134;72;74 11:38:17 INFO - PROCESS | 9542 | |4;audio-oscillator;97;98;139;96;96;97;142;96;97;146 11:38:17 INFO - PROCESS | 9542 | |5;imaging-gaussian-blur;109;110;110;110;109;109;110;110;109;110 11:38:17 INFO - PROCESS | 9542 | |6;imaging-darkroom;147;147;146;146;147;149;147;145;146;146 11:38:17 INFO - PROCESS | 9542 | |7;imaging-desaturate;97;96;97;97;101;97;96;95;96;96 11:38:17 INFO - PROCESS | 9542 | |8;json-parse-financial;59;60;61;59;61;59;60;62;63;57 11:38:17 INFO - PROCESS | 9542 | |9;json-stringify-tinderbox;67;69;67;68;69;68;68;67;67;68 11:38:17 INFO - PROCESS | 9542 | |10;stanford-crypto-aes;85;88;89;88;86;87;86;88;88;89 11:38:17 INFO - PROCESS | 9542 | |11;stanford-crypto-ccm;131;119;126;118;123;137;118;119;117;117 11:38:17 INFO - PROCESS | 9542 | |12;stanford-crypto-pbkdf2;150;150;142;154;151;157;151;154;150;139 11:38:17 INFO - PROCESS | 9542 | |13;stanford-crypto-sha256-iterative;67;67;67;71;70;70;67;69;69;70 11:38:17 INFO - PROCESS | 9542 | __end_tp_report 11:38:17 INFO - PROCESS | 9542 | __start_cc_report 11:38:17 INFO - PROCESS | 9542 | _x_x_mozilla_cycle_collect,749 11:38:17 INFO - PROCESS | 9542 | __end_cc_report 11:38:17 INFO - PROCESS | 9542 | __startTimestamp1452627497448__endTimestamp 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | ------- Summary: start ------- 11:38:17 INFO - PROCESS | 9542 | Number of tests: 14 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.00 stddev:3.73 (3.3%) stddev-sans-first:3.94 11:38:17 INFO - PROCESS | 9542 | Values: 112.0 109.0 113.0 112.0 112.0 123.0 111.0 112.0 113.0 112.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:154.50 stddev:16.98 (11.0%) stddev-sans-first:17.56 11:38:17 INFO - PROCESS | 9542 | Values: 157.0 127.0 152.0 165.0 127.0 149.0 162.0 129.0 167.0 127.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:1.99 (1.2%) stddev-sans-first:2.09 11:38:17 INFO - PROCESS | 9542 | Values: 162.0 163.0 161.0 165.0 162.0 161.0 162.0 164.0 167.0 161.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#3] audio-fft Cycles:10 Average:79.30 Median:73.50 stddev:19.26 (26.2%) stddev-sans-first:20.25 11:38:17 INFO - PROCESS | 9542 | Values: 72.0 75.0 75.0 72.0 74.0 72.0 73.0 134.0 72.0 74.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.50 stddev:22.11 (22.9%) stddev-sans-first:22.91 11:38:17 INFO - PROCESS | 9542 | Values: 97.0 98.0 139.0 96.0 96.0 97.0 142.0 96.0 97.0 146.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:38:17 INFO - PROCESS | 9542 | Values: 109.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 11:38:17 INFO - PROCESS | 9542 | Values: 147.0 147.0 146.0 146.0 147.0 149.0 147.0 145.0 146.0 146.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.50 stddev:1.62 (1.7%) stddev-sans-first:1.72 11:38:17 INFO - PROCESS | 9542 | Values: 97.0 96.0 97.0 97.0 101.0 97.0 96.0 95.0 96.0 96.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.50 stddev:1.73 (2.9%) stddev-sans-first:1.79 11:38:17 INFO - PROCESS | 9542 | Values: 59.0 60.0 61.0 59.0 61.0 59.0 60.0 62.0 63.0 57.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 11:38:17 INFO - PROCESS | 9542 | Values: 67.0 69.0 67.0 68.0 69.0 68.0 68.0 67.0 67.0 68.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:88.00 stddev:1.35 (1.5%) stddev-sans-first:1.12 11:38:17 INFO - PROCESS | 9542 | Values: 85.0 88.0 89.0 88.0 86.0 87.0 86.0 88.0 88.0 89.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:121.00 stddev:6.84 (5.6%) stddev-sans-first:6.52 11:38:17 INFO - PROCESS | 9542 | Values: 131.0 119.0 126.0 118.0 123.0 137.0 118.0 119.0 117.0 117.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.00 stddev:5.45 (3.6%) stddev-sans-first:5.78 11:38:17 INFO - PROCESS | 9542 | Values: 150.0 150.0 142.0 154.0 151.0 157.0 151.0 154.0 150.0 139.0 11:38:17 INFO - PROCESS | 9542 | 11:38:17 INFO - PROCESS | 9542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.57 (2.3%) stddev-sans-first:1.54 11:38:17 INFO - PROCESS | 9542 | Values: 67.0 67.0 67.0 71.0 70.0 70.0 67.0 69.0 69.0 70.0 11:38:17 INFO - PROCESS | 9542 | -------- Summary: end -------- 11:38:17 INFO - PROCESS | 9542 | 11:38:18 INFO - TEST-INFO | 9542: exit 0 11:38:18 INFO - TEST-OK | kraken | took 60110ms 11:38:18 INFO - TEST-START | v8_7 11:38:18 INFO - operating with platform_type : linux_ 11:38:18 INFO - Initialising browser for v8_7 test... 11:38:18 INFO - TEST-INFO | started process 9831 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9C05x4/profile http://localhost:48734/getInfo.html) 11:38:22 INFO - PROCESS | 9831 | 11:38:22 INFO - PROCESS | 9831 | (process:9905): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:38:22 INFO - PROCESS | 9831 | __metrics Screen width/height:1600/1200 11:38:22 INFO - PROCESS | 9831 | colorDepth:24 11:38:22 INFO - PROCESS | 9831 | Browser inner width/height: 1024/697 11:38:22 INFO - PROCESS | 9831 | __metrics 11:38:23 INFO - PROCESS | 9831 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:38:23 INFO - TEST-INFO | 9831: exit 0 11:38:23 INFO - Browser initialized. 11:38:23 INFO - Running cycle 1/1 for v8_7 test... 11:38:23 INFO - TEST-INFO | started process 9954 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9C05x4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:25 INFO - PROCESS | 9954 | 11:38:25 INFO - PROCESS | 9954 | (process:10013): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:38:35 INFO - PROCESS | 9954 | RSS: Main: 150118400 11:38:35 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | Cycle 1(1): loaded http://localhost:48734/tests/v8_7/run.html (next: http://localhost:48734/tests/v8_7/run.html) 11:38:58 INFO - PROCESS | 9954 | RSS: Main: 146137088 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | __start_tp_report 11:38:58 INFO - PROCESS | 9954 | _x_x_mozilla_page_load 11:38:58 INFO - PROCESS | 9954 | _x_x_mozilla_page_load_details 11:38:58 INFO - PROCESS | 9954 | |i|pagename|runs| 11:38:58 INFO - PROCESS | 9954 | |0;Richards;168.94745734076702 11:38:58 INFO - PROCESS | 9954 | |1;DeltaBlue;190.69412662090008 11:38:58 INFO - PROCESS | 9954 | |2;Encrypt;280.74115665356544 11:38:58 INFO - PROCESS | 9954 | |3;Decrypt;5268.421052631579 11:38:58 INFO - PROCESS | 9954 | |4;RayTrace;1097.694840834248 11:38:58 INFO - PROCESS | 9954 | |5;Earley;703.9381153305204 11:38:58 INFO - PROCESS | 9954 | |6;Boyer;12195.121951219513 11:38:58 INFO - PROCESS | 9954 | |7;RegExp;40700 11:38:58 INFO - PROCESS | 9954 | |8;Splay;583.7711617046118 11:38:58 INFO - PROCESS | 9954 | |9;NavierStokes;4830.917874396136 11:38:58 INFO - PROCESS | 9954 | __end_tp_report 11:38:58 INFO - PROCESS | 9954 | __startTimestamp1452627538334__endTimestamp 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | ------- Summary: start ------- 11:38:58 INFO - PROCESS | 9954 | Number of tests: 10 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#0] Richards Cycles:1 Average:168.95 Median:168.95 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 168.9 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#1] DeltaBlue Cycles:1 Average:190.69 Median:190.69 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 190.7 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 280.7 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 5268.4 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#4] RayTrace Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 1097.7 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#5] Earley Cycles:1 Average:703.94 Median:703.94 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 703.9 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 12195.1 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#7] RegExp Cycles:1 Average:40700.00 Median:40700.00 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 40700.0 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#8] Splay Cycles:1 Average:583.77 Median:583.77 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 583.8 11:38:58 INFO - PROCESS | 9954 | 11:38:58 INFO - PROCESS | 9954 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:38:58 INFO - PROCESS | 9954 | Values: 4830.9 11:38:58 INFO - PROCESS | 9954 | -------- Summary: end -------- 11:38:58 INFO - PROCESS | 9954 | 11:38:59 INFO - TEST-INFO | 9954: exit 0 11:38:59 INFO - TEST-OK | v8_7 | took 40801ms 11:38:59 INFO - SUITE-END | took 1210s 11:38:59 INFO - Completed test suite (00:20:11) 11:38:59 INFO - Working with test: dromaeo_css 11:38:59 INFO - Generating results file: dromaeo_css 11:38:59 INFO - Working with test: kraken 11:38:59 INFO - Generating results file: kraken 11:38:59 INFO - javascript benchmark 11:38:59 INFO - Working with test: v8_7 11:38:59 INFO - Generating results file: v8_7 11:38:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:38:59 INFO - process_Request line: dromaeo_css 6805.43 graph.html#tests=[[72,64,43]] 11:38:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:59 INFO - process_Request line: kraken 1520.90 graph.html#tests=[[232,64,43]] 11:38:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:59 INFO - process_Request line: v8_7 20364.09 graph.html#tests=[[230,64,43]] 11:38:59 INFO - RETURN: dromaeo_css: 6805.43 11:38:59 INFO - RETURN: kraken: 1520.90 11:38:59 INFO - RETURN: v8_7: 20364.09 11:38:59 INFO - javascript benchmark 11:38:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3160.4785210440277, 3172.9682703172966, 3188.52172174174, 3208.43852325843, 3210.0851257391646, 5072.974635126824, 5075.974620126899, 5112.258722485238, 5149.76826042828, 5185.299984502091, 5069.062223488657, 5120.257562653423, 5136.948630513693, 5147.897042059157, 5157.896842063156, 4652.627789776827, 4778.569928706415, 4791.904161916759, 4832.87917802056, 4849.345338379327, 688.8821239423327, 4749.311349854269, 4750.691205071676, 4751.0972915146185, 4776.259679749627, 4417.359482874997, 4717.882052948669, 4736.881577960544, 4790.484667366147, 4792.856214313576, 4778.593819525345, 4782.569568738831, 4806.4712881583, 4839.322494850724, 4842.806287748486, 4585.495595484494, 4829.637777166691, 4829.758512074382, 4834.323194752737, 4844.442889067732, 4959.727215003173, 5024.673396229234, 5029.17018691919, 5053.090443720129, 5069.543741063285, 5407.134858422633, 5426.864328391822, 5432.13085906257, 5440.4287549807495, 5451.700156491392, 5405.702686352249, 5454.209139674725, 5458.099413596752, 5480.123180291174, 5525.11598144299, 5150.793968241303, 5165.044466773659, 5175.404828444739, 5192.688438693653, 5248.8687782805355, 5540.501354878081, 5580.776768929198, 5609.214709940612, 5621.7751289948765, 5635.915461268084, 5284.180951952453, 5350.411454739976, 5414.133738601883, 5421.241026256327, 5472.042392581282, 5475.835724928259, 5493.148561972821, 5518.2826232590305, 5520.558355331564, 5561.77752889888, 5355.866103347447, 5359.5712343012465, 5404.756785944642, 5414.40441551429, 5428.212909128233, 5347.705876176848, 5401.729913504388, 5421.376541697677, 5422.539084177889, 5448.482394172547, 4321.69748117635, 4376.474823021258, 4390.209762242827, 4393.428854248928, 4420.115976804587, 3875.4961854958674, 3911.3546264866545, 3918.941215881764, 3930.1746633206776, 3942.9211415771524, 5131.589472842164, 5194.4026436959475, 5221.034108689904, 5228.816991405359, 5246.921296180561, 5402.837914862561, 5590.385057643656, 5628.465295796893, 5631.2397826293745, 5669.659820410789, 5096.61775366849, 5109.182530795055, 5138.537531622097, 5145.253938178943, 5185.740712964337, 4657.74382408964, 4732.148213321635, 4735.692180008288, 4738.73936933465, 4746.43042834862, 5821.621594596338, 5855.970720146457, 5858.0, 5870.26621672291, 5907.852303692442, 5418.295621569171, 5462.508374246337, 5466.262054622575, 5470.53500452466, 5481.698506582176, 5631.63394379364, 5647.322321321468, 5678.2050512929045, 5685.0, 5754.19441278213, 5433.402325744244, 5477.4796394342475, 5481.205225242397, 5494.7802087917635, 5539.086050801573, 5439.891202175855, 5479.123340265538, 5485.0, 5488.451154884479, 5491.121420572689, 5271.894562108813, 5344.35867695879, 5347.411784703757, 5362.570994320367, 5401.675899446046, 5461.617686761889, 5465.207544906046, 5489.204065410573, 5494.532964698045, 5502.0371434997915, 5338.946610533845, 5385.515303622693, 5386.946130538645, 5404.459554044564, 5435.130379139318, 5340.866478338073, 5385.461453854583, 5401.729913504388, 5482.506574408322, 5483.396826349019, 5260.263563101093, 5282.445343238905, 5287.68273903567, 5290.629655924048, 5296.443873393392], "unit": "score", "name": "dojo.html", "value": 5075.496986586541}, {"lowerIsBetter": false, "replicates": [525.3879230696239, 570.4951118260338, 581.5347721822541, 583.5506659871899, 593.382881802925, 34104.4884326735, 34522.0, 34719.0, 34788.652113478856, 34981.12547186322, 37966.0, 38184.04539886504, 38392.42411363832, 38437.80781096098, 38733.806330968306, 8313.127121652231, 8521.233089021987, 8531.744047678549, 8561.914380856175, 8577.742667719947, 8248.670053197864, 8428.53643049632, 8438.029626592928, 8536.957315213414, 8580.656773729042, 8568.571571421435, 8631.69789057383, 8674.479531228146, 8676.0, 8695.39132260742, 8543.914560854406, 8602.612882420306, 8612.483251004896, 8620.224179823846, 8646.61090250937, 8464.915350846475, 8532.658693652247, 8563.0, 8569.785755356104, 8586.055533891267, 35123.473147902805, 35368.646313536796, 35501.46747798759, 35530.64469355325, 35613.82193089018, 2924.1227631710403, 2973.5688325192727, 2982.597349357852, 3077.3845230953675, 3341.9498707519406, 27975.22334484839, 29167.85416072906, 29312.413751724845, 29324.853375733197, 30429.847850760605, 3109.4247564200696, 3124.562561241428, 3136.8588413521447, 3157.747380209578, 3169.8732050717945, 315290.0, 317174.0, 319442.0, 319814.0, 320099.1985120225, 40296.798516007235, 40760.59239407627, 53897.730511347974, 54269.1859622106, 54343.45656543384, 38629.0, 38739.0, 38769.0, 38782.612173878464, 39206.21587568233, 13300.600981970556, 13491.797623035662, 13518.662033449045, 13519.594412167651, 13543.796843047363, 11006.229563930608, 11025.117990560897, 11117.888821111846, 11127.165462590337, 11158.944205278922, 13458.865411345958, 13530.864691353157, 13825.170489770646, 13928.442862285396, 14004.85995140056, 5596.664200148004, 5681.886362272731, 5689.687067211343, 5763.135529670583, 5785.0, 916.867054277126, 988.9851652225223, 1006.993006993007, 1045.9529321180564, 1046.6441409920662, 27440.313992150357, 27960.72039279622, 28001.439971200463, 28101.297467563476, 28235.0, 971.577363846729, 980.8038392321564, 981.9754506137403, 1021.6168936648756, 1049.4280617063719, 13349.998750093782, 15946.36214551405, 16148.75776863348, 16227.188640567925, 16410.0, 394778.0, 395282.0, 395969.0, 396112.0, 396744.0, 50621.240681389805, 50814.23778643323, 51078.14757598022, 51329.48670513322, 51771.0, 1302.1210682789078, 1309.8493673227701, 1319.300770591588, 1324.0334555774145, 1327.575175943708, 27698.169054928385, 29004.419911601228, 29170.854145729136, 29201.85399072991, 29331.0, 42386.57613423826, 42759.93100172396, 42983.140337193705, 43084.569154308054, 43556.0, 297767.0, 297852.0, 299211.0, 299211.0, 299668.0, 30378.544321834746, 39097.21805563816, 39110.41334379929, 41085.0, 41421.0, 35899.82050089733, 36251.63748362483, 36265.27469450649, 37543.0, 38004.42993355047, 31866.840665796524, 32500.34999300048, 32658.34683306273, 32998.34003319872, 33025.0, 33054.0, 36979.63020369762, 37922.0, 38323.425148622235, 38536.80731596324, 32221.51667724939, 32253.35493290168, 32296.677033229367, 35361.46957795584, 36225.27549449049, 27977.44045119127, 29408.26479338034, 29580.852095739385, 29678.851605742697, 29832.403351932404, 22640.773592263868, 23334.649980250648, 23809.285721427692, 23916.52166956686, 23918.52162956766], "unit": "score", "name": "ext.html", "value": 17353.064523302062}, {"lowerIsBetter": false, "replicates": [355.848764275183, 359.39800833603715, 359.8614533404639, 361.33514333626124, 361.3838405518591, 15700.450484233053, 16137.515874523768, 16329.34682612694, 17063.40278090267, 17165.914170429147, 9531.0, 9707.174890134347, 13876.79184812226, 15937.0, 15961.361545538193, 4772.093302272575, 4793.856184314476, 4841.128596852565, 4845.515448455161, 4857.494176805184, 4754.453237877637, 4779.474257831635, 4790.640701947351, 4813.831515896944, 4865.172920603488, 4677.13473007493, 4917.680350777206, 6096.116063170837, 6355.2373715154245, 6365.52258580606, 6450.8064758057335, 6479.35206479353, 6495.155629768124, 6803.421709154728, 6844.828879278008, 6345.904811427832, 6543.836404089889, 6577.24361698406, 6586.571872828251, 6655.46756259498, 20420.489487762778, 20890.059947302256, 21210.151593936225, 21284.680729789066, 22160.667589986002, 2083.3020937985793, 2176.0, 2231.252530402317, 2350.6826578412038, 2355.340504658698, 7877.0, 13361.66595835102, 13521.0, 13872.861246409391, 13963.650908727363, 1939.156466936887, 1944.4166749974952, 1948.230448972662, 1974.0919177178514, 1997.4107638246608, 64599.354006459806, 66005.66997165032, 66798.66600667014, 67285.6635716828, 68138.31861681418, 14347.78478322826, 14702.485413010494, 14725.821934245234, 14747.18890461035, 14757.483488077865, 22611.0, 22731.88634056819, 22806.65790013151, 22873.771262287497, 22873.885630572073, 8516.914830851736, 8544.658213671384, 8751.868721969175, 8810.251128654008, 8860.512671803113, 7287.052683151156, 7326.93759404894, 7461.813454663568, 7565.6217189140325, 7599.582022988789, 7319.34125928669, 7362.337389634851, 7369.742059027908, 7399.519031263058, 7401.48189626721, 1663.6672665466713, 1749.1691446562781, 1771.5305444057335, 2918.64976202857, 3035.6964303569466, 828.0, 867.111211008721, 946.6781294359951, 962.0667952086465, 1044.4072788996841, 15721.606959826096, 15805.209739512979, 16059.598510037109, 16389.262483188286, 16710.24803883804, 925.1303774451993, 925.9166674999283, 945.3854994253653, 973.153356579766, 995.6913356859396, 9100.226480749077, 9244.722658320126, 9484.715458536255, 9580.904190958141, 9674.0, 510111.0, 514619.0, 521648.0, 569348.0, 570031.0, 70380.59238815196, 71177.0, 72738.0, 73847.0, 74159.62920185365, 1105.8507101541188, 1124.6457365929707, 1134.869490008643, 1134.8865113488584, 1151.7984352738238, 14914.776278355615, 14930.477433289783, 14992.700145997238, 15047.699046019237, 15074.321655525308, 30083.94706185273, 30130.84934575313, 30259.546106808855, 30486.847565762917, 32159.67840321567, 39359.40960885646, 39470.40794388029, 39675.40486892641, 40624.79687601543, 41095.1780964373, 6977.441804655514, 7052.153741551047, 7052.788416347517, 7305.1599066105955, 7424.814379640552, 10461.843072353768, 10634.468276586294, 10863.837042444527, 11297.71755706114, 11590.246633969102, 8787.165219304155, 9251.722448326562, 9690.806183876424, 9770.413775173512, 9976.25178111659, 9389.201917837061, 9391.530423478662, 9508.049195080437, 9728.17310528613, 9863.457509837028, 9529.618815247313, 9643.662471813454, 9692.176165026052, 9768.609255629695, 9798.559064841957, 6732.8653426930205, 6826.761063362758, 6867.553609015398, 6892.793216203522, 7047.119110111236, 8362.331013518782, 9701.902980970382, 9949.0, 10101.949490252502, 10179.134773544036], "unit": "score", "name": "jquery.html", "value": 8678.34176050808}, {"lowerIsBetter": false, "replicates": [1439.1365180891466, 1449.1812126148725, 1571.4521196621326, 1725.567778743643, 1734.3582874336505, 7700.768976930687, 7709.498882572629, 7883.132855385903, 7918.485298455604, 7920.247576480232, 7720.0735911690535, 7760.223977602237, 7762.883556746653, 7819.452638315321, 7843.450958432912, 2261.1520679745136, 2283.5318759654315, 2290.0725206291395, 2290.770922907704, 2291.0263138166297, 2261.389424855288, 2294.380517260339, 2328.371339738278, 2329.3827135809024, 2331.114176612885, 2212.3473575295325, 2257.2551058150852, 2264.8188144948363, 2278.3506700590333, 2289.0157232390147, 2249.190291495069, 2258.9435264118447, 2266.818654507652, 2275.5448910218024, 2283.4748007958096, 2239.193890199543, 2253.9774602253933, 2259.2883241778786, 2263.128695452246, 2264.9660255096187, 7625.656845441913, 7628.847423051508, 7635.618219089023, 7690.769276921701, 7699.153093159748, 4542.227821270392, 4641.257398816173, 4644.9535504644855, 4652.55800698933, 4666.416697912761, 2800.341919648881, 2829.688734239232, 2894.9710502894914, 2902.4195160967893, 2907.1569244918946, 949.4113649537331, 983.896690847465, 991.8264303746888, 1008.2438171371472, 1056.4717641179411, 10473.790524189473, 10596.152307815357, 10624.575016999312, 10633.680989570325, 10752.78494430115, 4062.878113656595, 4071.1247081877536, 4145.17096580685, 4154.91690166195, 4165.354370072643, 8540.829183416297, 8576.614052367659, 8596.097409772008, 8599.441036332619, 8617.138286171332, 4627.259638457831, 4635.490096089427, 4636.2581986882615, 4655.697379670379, 4660.161170989254, 4281.293586558245, 4291.098869237495, 4301.806418711166, 4308.310670292738, 4322.5519450984275, 3318.203631128512, 3356.56364672591, 3356.664333566624, 3359.5800524934384, 3380.2901390707734, 1012.8987101289812, 1023.81059503992, 1023.8976102389702, 1025.3489034463169, 1035.8342665173536, 943.056943056943, 948.0898337595847, 1020.3418794877263, 1068.5351871935577, 1252.6054292897709, 6905.37851593359, 6926.549774264657, 6929.896051559231, 6977.965110174417, 6989.4408447324095, 1086.179934149712, 1100.6037826382496, 1104.447776111944, 1123.8988491035846, 1138.8576427946507, 5532.280803495601, 5561.6663000220115, 5562.610617256834, 5628.746706398222, 5633.183188437653, 9174.128457796498, 9204.953975230215, 9554.044595540528, 9618.086281803218, 9714.368566043184, 9458.85811712825, 9464.432134071978, 9484.478353690476, 9486.383385079947, 9494.192993595483, 7249.202587715347, 7424.888626670496, 7469.327760501581, 7484.775456736306, 7574.545527268271, 7018.403435708022, 7028.753993610199, 7066.763316419709, 7115.288471152843, 7145.21402645719, 8220.3834712398, 8228.341732661253, 8535.402521823413, 8535.487870727777, 8609.268212201783, 8656.177663121993, 8701.738947831574, 8774.736757897273, 8786.868196977179, 8809.075047120217, 6584.736610535525, 6759.628220447923, 6793.388595026471, 6797.89803152963, 6823.249442561413, 7241.565506069653, 7282.563046217244, 7292.635368231673, 7297.489175757858, 7304.8539029218055, 6826.931730682828, 6986.860262794818, 7113.253108423541, 7121.572705637678, 7175.0, 6120.1125836752535, 6495.805125846232, 6807.21717002551, 6848.7260509579055, 6903.206131294965, 6953.6523173842115, 6963.268856769966, 6974.895376569457, 6996.300369962963, 7002.684879180551, 6320.841978950563, 6321.905171422341, 6369.936300636934, 6373.075903993988, 6380.776672816429, 6385.425311721968, 6426.100345951477, 6456.12842266288, 6463.353664633499, 6486.4486518646445], "unit": "score", "name": "mootools.html", "value": 4410.0514278498185}, {"lowerIsBetter": false, "replicates": [327.60196361420867, 328.08464384367613, 332.5992179423795, 333.9165208697824, 334.9430596798544, 6178.752849886005, 6184.443400093991, 6214.596051256671, 6269.905951410732, 6431.646259455728, 6122.724477398517, 6213.533984951124, 6224.751009959597, 6235.532335074876, 6238.781642642497, 4779.976100119512, 4786.449558300805, 4789.305550695164, 4792.520747925197, 4799.736014519218, 4753.595944344717, 4783.760811959405, 4795.736234507101, 4795.784189711471, 4802.5197480252045, 4668.25307950728, 4713.34013238147, 4719.669623126382, 4724.90550188996, 4737.336772851803, 4727.810887564493, 4733.739644319561, 4736.029114031632, 4739.7630118493935, 4742.2886567014875, 4105.67154627632, 4111.568285330057, 4111.938320925188, 4123.958760412387, 4133.379993001044, 5914.763409463616, 5920.703964801743, 5923.5853490255695, 5924.437178468082, 5933.525317974551, 5406.378266499363, 5509.090999984997, 5511.338639363302, 5516.475934786189, 5524.889502209973, 6569.671516424208, 6587.637679927602, 6603.867922641568, 6606.339366063403, 6610.8016759497295, 4561.543845615445, 4578.153041687298, 4585.656075794329, 4585.885352866172, 4589.862304130881, 6725.630090345029, 6788.76239331621, 6876.415504682108, 6880.139982502187, 6896.482763792736, 4626.467956185082, 4635.443746750344, 4646.697964632288, 4652.744099074584, 4655.138799322136, 4679.532046795293, 4702.6708130431225, 4705.811767529261, 4711.128441238313, 4712.88217794551, 5437.619366644376, 5440.966216418868, 5445.673259604437, 5449.01917654826, 5453.4273901240595, 6539.182602174728, 6591.670416479157, 6630.138082049302, 6638.7676431325635, 6641.767538136142, 1613.6691978144452, 1638.9262483188286, 1653.4047742812577, 1655.6771429571359, 1659.2284587666793, 1082.334364365925, 1099.3458891959272, 1099.378850949211, 1100.862392200975, 1110.4669758515959, 6171.814845554641, 6181.114759998244, 6186.752529898844, 6218.440340369298, 6232.189815323979, 6661.067450556926, 6664.633445160466, 6720.1599800025, 6731.697073631698, 6737.157855268091, 6070.3019152798, 6198.2252218472695, 6205.317415084337, 6214.378562143749, 6222.346653601307, 3654.068212605822, 3673.1368128489785, 3675.6691897729334, 3676.761010534307, 3681.3557627415094, 7086.4685148613025, 7089.7873063808165, 7090.432765378758, 7094.361507464249, 7102.254263302382, 6691.866162676719, 6831.726730930707, 6877.4841886858685, 6879.140107486564, 6898.7240510380025, 7038.859222815618, 7056.223815380304, 7077.327653872874, 7088.716451341888, 7096.92903070973, 6667.599944003376, 6680.799576012728, 6692.665366731741, 6701.296363881722, 6723.462123030244, 6521.771737989147, 6607.834804129935, 6637.037629543593, 6642.3025582315095, 6645.534812563074, 7031.824204394931, 7054.365107140382, 7058.647067646494, 7064.434845212473, 7072.186698529735, 4621.3530105785885, 4632.0, 4639.188142075056, 4643.976780116213, 4647.442306923191, 6677.031830384664, 6691.263960964193, 6696.363845434676, 6710.0, 6865.519413640997, 6651.268360480247, 6669.4664426844765, 6670.966645166937, 6687.164104486939, 6703.798886033232, 6637.336266373324, 6638.900416493853, 6651.73393064272, 6665.133532640726, 6689.063531105747, 6460.25707043696, 6551.44312733404, 6555.770548030796, 6574.342565743387, 6583.473322134122, 6672.599644021374, 6695.7321707133115, 6728.293529179561, 6732.495062870402, 6738.797836064926, 6498.415142637185, 6507.446867016357, 6516.218053833571, 6548.148740663683, 6562.179727534059], "unit": "score", "name": "prototype.html", "value": 4953.647099615302}, {"lowerIsBetter": false, "replicates": [633.1990032608747, 634.3086036220519, 675.6013951768457, 690.7064497588524, 776.0338378718495, 13253.668658283535, 13328.600141995732, 13363.398647060882, 13437.865621343795, 15063.322150503227, 13707.0, 13823.170609763421, 13840.653983650414, 13878.514252001181, 13916.373763180656, 765.0360545712415, 768.1358471719329, 773.342658740072, 776.7825008997462, 780.2938340801584, 775.1008829757483, 776.0997243197892, 776.9300762931335, 777.3547955197173, 779.6374685771116, 800.6917336825306, 810.1979040749645, 810.7040930060515, 812.102626597607, 813.1055838577577, 799.6001999000529, 799.7200979657132, 800.415696541525, 800.9799755006143, 809.5749731391008, 595.9702014899237, 598.1327075740151, 599.8530360061769, 601.0653433910268, 601.6029420582438, 12843.614691559269, 12908.290044047573, 12913.548025819051, 12980.805287920593, 13032.609021729364, 11688.240264382874, 12001.459934302977, 12074.637760867101, 12192.634220973385, 12329.445174967148, 9359.618194603028, 9598.328117031811, 9616.23070154386, 9713.174380177623, 9961.103500684972, 3261.1031966209243, 3288.720458761008, 3311.4536101543217, 3391.542141810873, 3427.2974040321924, 47053.52946470526, 47596.0, 47667.76166119182, 47905.520944790806, 48187.518124819006, 8749.931881121414, 8797.824043519095, 9145.90854091464, 9225.630974761069, 9382.5308734563, 16947.237374318185, 17130.828691713174, 17164.227609757592, 17212.569685757957, 17218.483445496655, 6721.462283017347, 6726.125603671491, 6753.831154221086, 6782.830429239309, 7061.540999834994, 3917.8236979335998, 3946.131850992777, 4033.3748269018347, 4085.2442298174933, 4117.91764164715, 2912.039027121045, 2915.3149009982635, 2943.058221369184, 2949.8230106193696, 2953.896613618556, 522.7699812082672, 544.0940833512158, 554.2628304355198, 570.5606682854179, 570.8515785895697, 470.87757183132635, 538.7252501224325, 585.7978997245943, 591.819495054004, 608.4767100293744, 7827.412944029106, 7999.480033797785, 8085.959570202229, 8172.7956801080445, 8211.753647390588, 517.1957605922826, 541.769747857167, 555.4639772619441, 618.2241287184554, 645.1806206118204, 3787.280416720814, 3850.1914597934187, 3879.6702280305926, 3984.7609143450904, 4128.153728485653, 49687.50312496829, 49893.0, 49998.500015000114, 57724.0, 59053.70473147607, 46162.769186154525, 46240.0, 46244.76877615591, 46351.76824115858, 48517.75741121272, 45131.32303015458, 45251.0, 45629.31556026596, 47090.5290947093, 47253.0, 8285.751427457186, 8350.916490835014, 8458.984921809422, 8464.70373536948, 8642.697505587274, 33913.66086339105, 34691.653083468846, 34808.65191348054, 35194.0, 35965.280694385445, 42411.787941060094, 44127.77936110427, 44701.32948005848, 44730.0, 44948.77525612351, 10376.377417354983, 10414.323069000491, 10531.104856087319, 10835.317234449818, 10908.127349812155, 10093.041161089684, 10181.269184238845, 10277.588896444058, 10379.844302335621, 10939.945300273766, 10204.693859183939, 10429.791404171723, 10431.269811113149, 10703.357798532114, 10781.137508999105, 10022.749431264278, 10121.481658358694, 10149.34029288094, 10193.0, 10404.791904161722, 10363.963603639575, 10756.408397538211, 10817.945910270713, 10892.945535272273, 10907.647657083196, 8611.5494317871, 8617.913820861711, 8629.741107766777, 8711.738647840575, 8980.416272942239, 8406.327493800603, 8716.302695784196, 9267.67563135287, 9272.675456358995, 9306.221993099958], "unit": "score", "name": "yui.html", "value": 5948.869111628557}], "name": "dromaeo_css", "value": 6805.4250257076}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 113.0, 112.0, 112.0, 123.0, 111.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 152.0, 165.0, 127.0, 149.0, 162.0, 129.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 165.0, 162.0, 161.0, 162.0, 164.0, 167.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 75.0, 72.0, 74.0, 72.0, 73.0, 134.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 139.0, 96.0, 96.0, 97.0, 142.0, 96.0, 97.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 149.0, 147.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 101.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 61.0, 59.0, 61.0, 59.0, 60.0, 62.0, 63.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 89.0, 88.0, 86.0, 87.0, 86.0, 88.0, 88.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [131.0, 119.0, 126.0, 118.0, 123.0, 137.0, 118.0, 119.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [150.0, 150.0, 142.0, 154.0, 151.0, 157.0, 151.0, 154.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 71.0, 70.0, 70.0, 67.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1520.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.94745734076702], "unit": "score", "name": "Richards", "value": 208.952538}, {"lowerIsBetter": false, "replicates": [190.69412662090008], "unit": "score", "name": "DeltaBlue", "value": 346.72279200000014}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1097.694840834248], "unit": "score", "name": "RayTrace", "value": 674.1299790000003}, {"lowerIsBetter": false, "replicates": [703.9381153305204], "unit": "score", "name": "Earley", "value": 946.7636223776225}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [40700.0], "unit": "score", "name": "RegExp", "value": 22.382923832923854}, {"lowerIsBetter": false, "replicates": [583.7711617046118], "unit": "score", "name": "Splay", "value": 139.59408299999993}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20364.094948228947}]} 11:38:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20364.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1520.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6805.43"}}} 11:38:59 INFO - Return code: 0 11:38:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:38:59 INFO - # TBPL SUCCESS # 11:38:59 INFO - Running post-action listener: _resource_record_post_action 11:38:59 INFO - Running post-run listener: _resource_record_post_run 11:39:00 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 556941312; Read time: 0; Write time: 547872 11:39:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247402496; Read time: 0; Write time: 279476 11:39:00 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 309538816; Read time: 0; Write time: 268396 11:39:00 INFO - Running post-run listener: _upload_blobber_files 11:39:00 INFO - Blob upload gear active. 11:39:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:39:00 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:39:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:39:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:39:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:02 INFO - (blobuploader) - INFO - Done attempting. 11:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:03 INFO - (blobuploader) - INFO - Done attempting. 11:39:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:03 INFO - Return code: 0 11:39:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:39:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acf150d164394d53effc9584f0fd01ca07ca8613c7a302f52720e7c932cd9756baa6197684f531c826a9d4508c17b24e380d8c013abfc8de5e8ca2b103a1a2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5420eff7f5332db12f80a84f78cde5086a10ce25a808af50886875f772c7c0cfa5f427a7d866144111a4edcf1a10d26be62844b8e44ab062e6ab9eb96ddc5ff6"} 11:39:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:39:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:39:03 INFO - Contents: 11:39:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acf150d164394d53effc9584f0fd01ca07ca8613c7a302f52720e7c932cd9756baa6197684f531c826a9d4508c17b24e380d8c013abfc8de5e8ca2b103a1a2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5420eff7f5332db12f80a84f78cde5086a10ce25a808af50886875f772c7c0cfa5f427a7d866144111a4edcf1a10d26be62844b8e44ab062e6ab9eb96ddc5ff6"} 11:39:03 INFO - Copying logs to upload dir... 11:39:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.568613 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-12 11:39:03.906094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 11:39:03.910120) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 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/acf150d164394d53effc9584f0fd01ca07ca8613c7a302f52720e7c932cd9756baa6197684f531c826a9d4508c17b24e380d8c013abfc8de5e8ca2b103a1a2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5420eff7f5332db12f80a84f78cde5086a10ce25a808af50886875f772c7c0cfa5f427a7d866144111a4edcf1a10d26be62844b8e44ab062e6ab9eb96ddc5ff6"} build_url:https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/F0oF1DccQS6XNPapH5Nd3w/artifacts/public/build/firefox-46.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/acf150d164394d53effc9584f0fd01ca07ca8613c7a302f52720e7c932cd9756baa6197684f531c826a9d4508c17b24e380d8c013abfc8de5e8ca2b103a1a2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5420eff7f5332db12f80a84f78cde5086a10ce25a808af50886875f772c7c0cfa5f427a7d866144111a4edcf1a10d26be62844b8e44ab062e6ab9eb96ddc5ff6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 11:39:03.936425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:39:03.936793) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452626271.772079-1526919142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004767 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 11:39:04.019240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 11:39:04.019617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 11:39:04.020329) ========= ========= Total master_lag: 0.21 =========