builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1453619112.52 results: success (0) buildid: 20160123203118 builduid: d9a8105df4b44f87b97b1d32c66078e0 revision: c2abac115afa756db2aa05fed2a7491d60093ed3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.517704) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.518504) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.518824) ========= 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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006358 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.575075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.575550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.675195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.675497) ========= 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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.744570) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.744898) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.745300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.745615) ========= 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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 23:05:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-01-23 23:05:13 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.941088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.941471) ========= 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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018202 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.990910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:12.991270) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2abac115afa756db2aa05fed2a7491d60093ed3 --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 c2abac115afa756db2aa05fed2a7491d60093ed3 --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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 23:05:13,880 truncating revision to first 12 chars 2016-01-23 23:05:13,880 Setting DEBUG logging. 2016-01-23 23:05:13,880 attempt 1/10 2016-01-23 23:05:13,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2abac115afa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 23:05:14,124 unpacking tar archive at: fx-team-c2abac115afa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:13.568755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:13.569245) ========= echo c2abac115afa756db2aa05fed2a7491d60093ed3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c2abac115afa756db2aa05fed2a7491d60093ed3'] 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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c2abac115afa756db2aa05fed2a7491d60093ed3 program finished with exit code 0 elapsedTime=0.004643 script_repo_revision: 'c2abac115afa756db2aa05fed2a7491d60093ed3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:13.620915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:13.621288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 23:05:13.632022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-23 23:05:13.632365) ========= /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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:05:14 INFO - MultiFileLogger online at 20160123 23:05:14 in /builds/slave/test-pgo 23:05:14 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 23:05:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:05:14 INFO - {'append_to_log': False, 23:05:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:05:14 INFO - 'blob_upload_branch': 'Fx-Team', 23:05:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:05:14 INFO - 'branch': 'Fx-Team', 23:05:14 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:14 INFO - 'config_files': ('talos/linux_config.py',), 23:05:14 INFO - 'default_actions': ('clobber', 23:05:14 INFO - 'read-buildbot-config', 23:05:14 INFO - 'download-and-extract', 23:05:14 INFO - 'populate-webroot', 23:05:14 INFO - 'create-virtualenv', 23:05:14 INFO - 'install', 23:05:14 INFO - 'run-tests'), 23:05:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:14 INFO - 'download_minidump_stackwalk': True, 23:05:14 INFO - 'download_symbols': 'ondemand', 23:05:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:14 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:14 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:14 INFO - 'installer_path': 'installer.exe', 23:05:14 INFO - 'log_level': 'info', 23:05:14 INFO - 'log_name': 'talos', 23:05:14 INFO - 'log_to_console': True, 23:05:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:05:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:05:14 INFO - 'opt_config_files': (), 23:05:14 INFO - 'pip_index': False, 23:05:14 INFO - 'sps_profile': False, 23:05:14 INFO - 'sps_profile_interval': 0, 23:05:14 INFO - 'suite': 'dromaeojs-e10s', 23:05:14 INFO - 'system_bits': '32', 23:05:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:14 INFO - 'title': 'talos-linux64-ix-050', 23:05:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:14 INFO - 'use_talos_json': True, 23:05:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:05:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:14 INFO - 'work_dir': 'build'} 23:05:14 INFO - ##### 23:05:14 INFO - ##### Running clobber step. 23:05:14 INFO - ##### 23:05:14 INFO - Running pre-action listener: _resource_record_pre_action 23:05:14 INFO - Running main action method: clobber 23:05:14 INFO - rmtree: /builds/slave/test-pgo/build 23:05:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:05:15 INFO - Running post-action listener: _resource_record_post_action 23:05:15 INFO - ##### 23:05:15 INFO - ##### Running read-buildbot-config step. 23:05:15 INFO - ##### 23:05:15 INFO - Running pre-action listener: _resource_record_pre_action 23:05:15 INFO - Running main action method: read_buildbot_config 23:05:15 INFO - Using buildbot properties: 23:05:15 INFO - { 23:05:15 INFO - "project": "", 23:05:15 INFO - "product": "firefox", 23:05:15 INFO - "script_repo_revision": "production", 23:05:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:05:15 INFO - "repository": "", 23:05:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:05:15 INFO - "buildid": "20160123203118", 23:05:15 INFO - "pgo_build": "True", 23:05:15 INFO - "basedir": "/builds/slave/test-pgo", 23:05:15 INFO - "buildnumber": 241, 23:05:15 INFO - "slavename": "talos-linux64-ix-050", 23:05:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:05:15 INFO - "platform": "ubuntu64_hw", 23:05:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:05:15 INFO - "branch": "fx-team", 23:05:15 INFO - "repo_path": "integration/fx-team", 23:05:15 INFO - "revision": "c2abac115afa756db2aa05fed2a7491d60093ed3", 23:05:15 INFO - "stage_platform": "linux64-pgo", 23:05:15 INFO - "builduid": "d9a8105df4b44f87b97b1d32c66078e0", 23:05:15 INFO - "slavebuilddir": "test" 23:05:15 INFO - } 23:05:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:05:15 INFO - Running post-action listener: _resource_record_post_action 23:05:15 INFO - ##### 23:05:15 INFO - ##### Running download-and-extract step. 23:05:15 INFO - ##### 23:05:15 INFO - Running pre-action listener: _resource_record_pre_action 23:05:15 INFO - Running main action method: download_and_extract 23:05:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:05: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')]} 23:05:15 INFO - https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/test_packages.json 23:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/test_packages.json 23:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:05:23 INFO - Downloaded 1448 bytes. 23:05:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:05:23 INFO - Using the following test package requirements: 23:05:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:05:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:05:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'jsshell-linux-x86_64.zip'], 23:05:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:05:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:05:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:05:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:05:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:05:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:23 INFO - https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:35 INFO - Downloaded 22490559 bytes. 23:05:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:05:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:05:37 INFO - Return code: 0 23:05:37 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 23:05:37 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')]} 23:05:37 INFO - https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:05:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:38 INFO - Downloaded 22490559 bytes. 23:05:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:05:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:05:40 INFO - Return code: 0 23:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:40 INFO - https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:40 INFO - Downloaded 10706572 bytes. 23:05:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:05:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:05:41 INFO - Return code: 0 23:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:05:41 INFO - https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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 23:05:42 INFO - Downloaded 55979048 bytes. 23:05:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:42 INFO - mkdir: /builds/slave/test-pgo/properties 23:05:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:05:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:05:42 INFO - Contents: 23:05:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:05:42 INFO - Running post-action listener: _resource_record_post_action 23:05:42 INFO - Running post-action listener: set_extra_try_arguments 23:05:42 INFO - ##### 23:05:42 INFO - ##### Running populate-webroot step. 23:05:42 INFO - ##### 23:05:42 INFO - Running pre-action listener: _resource_record_pre_action 23:05:42 INFO - Running main action method: populate_webroot 23:05:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:42 INFO - '--tppagecycles', 23:05:42 INFO - '7'], 23:05:42 INFO - 'tests': ['tsvgm']}}, 23:05:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:05:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:05:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:05:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'tests': ['damp', 'tps']}, 23:05:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['damp', 'tps']}, 23:05:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:05:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:42 INFO - 'other': {'tests': ['a11yr', 23:05:42 INFO - 'ts_paint', 23:05:42 INFO - 'tpaint', 23:05:42 INFO - 'sessionrestore', 23:05:42 INFO - 'sessionrestore_no_auto_restore']}, 23:05:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['a11yr', 23:05:42 INFO - 'ts_paint', 23:05:42 INFO - 'tpaint', 23:05:42 INFO - 'sessionrestore', 23:05:42 INFO - 'sessionrestore_no_auto_restore']}, 23:05:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['a11yr', 23:05:42 INFO - 'ts_paint', 23:05:42 INFO - 'tpaint', 23:05:42 INFO - 'sessionrestore', 23:05:42 INFO - 'sessionrestore_no_auto_restore']}, 23:05:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['a11yr', 23:05:42 INFO - 'ts_paint', 23:05:42 INFO - 'tpaint', 23:05:42 INFO - 'sessionrestore', 23:05:42 INFO - 'sessionrestore_no_auto_restore']}, 23:05:42 INFO - 'other_l64': {'tests': ['a11yr', 23:05:42 INFO - 'ts_paint', 23:05:42 INFO - 'tpaint', 23:05:42 INFO - 'sessionrestore', 23:05:42 INFO - 'sessionrestore_no_auto_restore']}, 23:05:42 INFO - 'other_nol64': {'tests': ['a11yr', 23:05:42 INFO - 'ts_paint', 23:05:42 INFO - 'tpaint', 23:05:42 INFO - 'sessionrestore', 23:05:42 INFO - 'sessionrestore_no_auto_restore']}, 23:05:42 INFO - 'svgr': {'tests': ['tsvgx', 23:05:42 INFO - 'tsvgr_opacity', 23:05:42 INFO - 'tart', 23:05:42 INFO - 'tscrollx', 23:05:42 INFO - 'cart']}, 23:05:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['tsvgx', 23:05:42 INFO - 'tsvgr_opacity', 23:05:42 INFO - 'tart', 23:05:42 INFO - 'tscrollx', 23:05:42 INFO - 'cart']}, 23:05:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'tests': ['tp5o']}, 23:05:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'talos_options': ['--e10s'], 23:05:42 INFO - 'tests': ['tp5o']}, 23:05:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'talos_options': ['--xperf_path', 23:05:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:42 INFO - 'tests': ['tp5n']}, 23:05:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:42 INFO - 'talos_options': ['--e10s', 23:05:42 INFO - '--xperf_path', 23:05:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:42 INFO - 'tests': ['tp5n']}}, 23:05:42 INFO - 'talos.zip': {'path': '', 23:05:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:42 INFO - Running post-action listener: _resource_record_post_action 23:05:42 INFO - ##### 23:05:42 INFO - ##### Running create-virtualenv step. 23:05:42 INFO - ##### 23:05:42 INFO - Running pre-action listener: _resource_record_pre_action 23:05:42 INFO - Running main action method: create_virtualenv 23:05:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:05:42 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 23:05:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:05:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:42 INFO - Using real prefix '/usr' 23:05:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:05:43 INFO - Installing distribute.............................................................................................................................................................................................done. 23:05:45 INFO - Installing pip.................done. 23:05:45 INFO - Return code: 0 23:05:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:05:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 23:05:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:05:45 INFO - Using env: {'DISPLAY': ':0', 23:05:45 INFO - 'HOME': '/home/cltbld', 23:05:45 INFO - 'LANG': 'en_US.UTF-8', 23:05:45 INFO - 'LANGUAGE': 'en_US:en', 23:05:45 INFO - 'LOGNAME': 'cltbld', 23:05:45 INFO - 'MAIL': '/var/mail/cltbld', 23:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:45 INFO - 'MOZ_NO_REMOTE': '1', 23:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:45 INFO - 'NO_EM_RESTART': '1', 23:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:45 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:45 INFO - 'SHELL': '/bin/bash', 23:05:45 INFO - 'SHLVL': '1', 23:05:45 INFO - 'TERM': 'linux', 23:05:45 INFO - 'TMOUT': '86400', 23:05:45 INFO - 'USER': 'cltbld', 23:05:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:45 INFO - '_': '/tools/buildbot/bin/python'} 23:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:45 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 23:05:45 INFO - Cleaning up... 23:05:45 INFO - Return code: 0 23:05:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:05:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 23:05:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:05:45 INFO - Using env: {'DISPLAY': ':0', 23:05:45 INFO - 'HOME': '/home/cltbld', 23:05:45 INFO - 'LANG': 'en_US.UTF-8', 23:05:45 INFO - 'LANGUAGE': 'en_US:en', 23:05:45 INFO - 'LOGNAME': 'cltbld', 23:05:45 INFO - 'MAIL': '/var/mail/cltbld', 23:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:45 INFO - 'MOZ_NO_REMOTE': '1', 23:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:45 INFO - 'NO_EM_RESTART': '1', 23:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:45 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:45 INFO - 'SHELL': '/bin/bash', 23:05:45 INFO - 'SHLVL': '1', 23:05:45 INFO - 'TERM': 'linux', 23:05:45 INFO - 'TMOUT': '86400', 23:05:45 INFO - 'USER': 'cltbld', 23:05:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:45 INFO - '_': '/tools/buildbot/bin/python'} 23:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:45 INFO - Downloading/unpacking psutil>=0.7.1 23:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:05:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:47 INFO - Installing collected packages: psutil 23:05:47 INFO - Running setup.py install for psutil 23:05:47 INFO - building 'psutil._psutil_linux' extension 23:05:47 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 23:05:47 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 23:05:47 INFO - building 'psutil._psutil_posix' extension 23:05:47 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 23:05:48 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 23:05:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:48 INFO - Successfully installed psutil 23:05:48 INFO - Cleaning up... 23:05:48 INFO - Return code: 0 23:05:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:05:48 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')]} 23:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:48 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')]} 23:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:05:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 23:05:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:05:48 INFO - Using env: {'DISPLAY': ':0', 23:05:48 INFO - 'HOME': '/home/cltbld', 23:05:48 INFO - 'LANG': 'en_US.UTF-8', 23:05:48 INFO - 'LANGUAGE': 'en_US:en', 23:05:48 INFO - 'LOGNAME': 'cltbld', 23:05:48 INFO - 'MAIL': '/var/mail/cltbld', 23:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:48 INFO - 'MOZ_NO_REMOTE': '1', 23:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:48 INFO - 'NO_EM_RESTART': '1', 23:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:48 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:48 INFO - 'SHELL': '/bin/bash', 23:05:48 INFO - 'SHLVL': '1', 23:05:48 INFO - 'TERM': 'linux', 23:05:48 INFO - 'TMOUT': '86400', 23:05:48 INFO - 'USER': 'cltbld', 23:05:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:48 INFO - '_': '/tools/buildbot/bin/python'} 23:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:48 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 23:05:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:05:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:05:50 INFO - Installing collected packages: mozsystemmonitor 23:05:50 INFO - Running setup.py install for mozsystemmonitor 23:05:50 INFO - Successfully installed mozsystemmonitor 23:05:50 INFO - Cleaning up... 23:05:50 INFO - Return code: 0 23:05:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:05:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 23:05:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:05:50 INFO - Using env: {'DISPLAY': ':0', 23:05:50 INFO - 'HOME': '/home/cltbld', 23:05:50 INFO - 'LANG': 'en_US.UTF-8', 23:05:50 INFO - 'LANGUAGE': 'en_US:en', 23:05:50 INFO - 'LOGNAME': 'cltbld', 23:05:50 INFO - 'MAIL': '/var/mail/cltbld', 23:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:50 INFO - 'MOZ_NO_REMOTE': '1', 23:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:50 INFO - 'NO_EM_RESTART': '1', 23:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:50 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:50 INFO - 'SHELL': '/bin/bash', 23:05:50 INFO - 'SHLVL': '1', 23:05:50 INFO - 'TERM': 'linux', 23:05:50 INFO - 'TMOUT': '86400', 23:05:50 INFO - 'USER': 'cltbld', 23:05:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:50 INFO - '_': '/tools/buildbot/bin/python'} 23:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:50 INFO - Downloading/unpacking blobuploader==1.2.4 23:05:50 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 23:05:50 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 23:05:50 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 23:05:50 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 23:05:50 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 23:05:50 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 23:05:52 INFO - Downloading blobuploader-1.2.4.tar.gz 23:05:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:05:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:05:52 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 23:05:52 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 23:05:52 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 23:05:52 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 23:05:52 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 23:05:52 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 23:05:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:05:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:05:52 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 23:05:52 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 23:05:52 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 23:05:52 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 23:05:52 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 23:05:52 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 23:05:53 INFO - Downloading docopt-0.6.1.tar.gz 23:05:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:05:53 INFO - Installing collected packages: blobuploader, requests, docopt 23:05:53 INFO - Running setup.py install for blobuploader 23:05:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:05:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:05:53 INFO - Running setup.py install for requests 23:05:53 INFO - Running setup.py install for docopt 23:05:53 INFO - Successfully installed blobuploader requests docopt 23:05:53 INFO - Cleaning up... 23:05:53 INFO - Return code: 0 23:05:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:05:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 23:05:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 23:05:53 INFO - Using env: {'DISPLAY': ':0', 23:05:53 INFO - 'HOME': '/home/cltbld', 23:05:53 INFO - 'LANG': 'en_US.UTF-8', 23:05:53 INFO - 'LANGUAGE': 'en_US:en', 23:05:53 INFO - 'LOGNAME': 'cltbld', 23:05:53 INFO - 'MAIL': '/var/mail/cltbld', 23:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:53 INFO - 'MOZ_NO_REMOTE': '1', 23:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:53 INFO - 'NO_EM_RESTART': '1', 23:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:53 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:53 INFO - 'SHELL': '/bin/bash', 23:05:53 INFO - 'SHLVL': '1', 23:05:53 INFO - 'TERM': 'linux', 23:05:53 INFO - 'TMOUT': '86400', 23:05:53 INFO - 'USER': 'cltbld', 23:05:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:53 INFO - '_': '/tools/buildbot/bin/python'} 23:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:54 INFO - Running setup.py (path:/tmp/pip-ZmDsbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:54 INFO - Running setup.py (path:/tmp/pip-q7oNMx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:54 INFO - Running setup.py (path:/tmp/pip-hD_Por-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:54 INFO - Running setup.py (path:/tmp/pip-x1RWbq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:54 INFO - Running setup.py (path:/tmp/pip-NlQukX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:54 INFO - Running setup.py (path:/tmp/pip-gqKZLs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:54 INFO - Running setup.py (path:/tmp/pip-bcDXO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:54 INFO - Running setup.py (path:/tmp/pip-BMDRsP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:54 INFO - Running setup.py (path:/tmp/pip-PmiWsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:54 INFO - Running setup.py (path:/tmp/pip-C2ObEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:54 INFO - Running setup.py (path:/tmp/pip-1pbx5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:54 INFO - Running setup.py (path:/tmp/pip-S_HmUh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:54 INFO - Running setup.py (path:/tmp/pip-3nz8Z2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:54 INFO - Running setup.py (path:/tmp/pip-qVcgb3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:55 INFO - Running setup.py (path:/tmp/pip-9gZrNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:55 INFO - Running setup.py (path:/tmp/pip-Tii7vG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:55 INFO - Running setup.py (path:/tmp/pip-aBdmMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:05:55 INFO - Running setup.py install for manifestparser 23:05:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:05:55 INFO - Running setup.py install for mozcrash 23:05:55 INFO - Running setup.py install for mozdebug 23:05:55 INFO - Running setup.py install for mozdevice 23:05:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:05:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:05:55 INFO - Running setup.py install for mozfile 23:05:55 INFO - Running setup.py install for mozhttpd 23:05:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:05:55 INFO - Running setup.py install for mozinfo 23:05:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:05:55 INFO - Running setup.py install for mozInstall 23:05:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Running setup.py install for mozleak 23:05:56 INFO - Running setup.py install for mozlog 23:05:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Running setup.py install for moznetwork 23:05:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Running setup.py install for mozprocess 23:05:56 INFO - Running setup.py install for mozprofile 23:05:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Running setup.py install for mozrunner 23:05:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Running setup.py install for mozscreenshot 23:05:56 INFO - Running setup.py install for moztest 23:05:56 INFO - Running setup.py install for mozversion 23:05:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:05:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:05:56 INFO - Cleaning up... 23:05:57 INFO - Return code: 0 23:05:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:05:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 23:05:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 23:05:57 INFO - Using env: {'DISPLAY': ':0', 23:05:57 INFO - 'HOME': '/home/cltbld', 23:05:57 INFO - 'LANG': 'en_US.UTF-8', 23:05:57 INFO - 'LANGUAGE': 'en_US:en', 23:05:57 INFO - 'LOGNAME': 'cltbld', 23:05:57 INFO - 'MAIL': '/var/mail/cltbld', 23:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:57 INFO - 'MOZ_NO_REMOTE': '1', 23:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:57 INFO - 'NO_EM_RESTART': '1', 23:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:05:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:05:57 INFO - 'SHELL': '/bin/bash', 23:05:57 INFO - 'SHLVL': '1', 23:05:57 INFO - 'TERM': 'linux', 23:05:57 INFO - 'TMOUT': '86400', 23:05:57 INFO - 'USER': 'cltbld', 23:05:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:57 INFO - '_': '/tools/buildbot/bin/python'} 23:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:57 INFO - Running setup.py (path:/tmp/pip-8538qP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:57 INFO - Running setup.py (path:/tmp/pip-qC439e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:57 INFO - Running setup.py (path:/tmp/pip-Er4Tx2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:57 INFO - Running setup.py (path:/tmp/pip-JT9RiR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:57 INFO - Running setup.py (path:/tmp/pip-5r3bar-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:57 INFO - Running setup.py (path:/tmp/pip-18tWSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:57 INFO - Running setup.py (path:/tmp/pip-QTAFaL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:57 INFO - Running setup.py (path:/tmp/pip-L5lzfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:57 INFO - Running setup.py (path:/tmp/pip-2Al_HR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:57 INFO - Running setup.py (path:/tmp/pip-Kij3Si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:05:57 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)) 23:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:57 INFO - Running setup.py (path:/tmp/pip-Sm4UVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:05:58 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)) 23:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:58 INFO - Running setup.py (path:/tmp/pip-ZMIhx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:05:58 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)) 23:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:58 INFO - Running setup.py (path:/tmp/pip-3qQFDE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:05:58 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)) 23:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:58 INFO - Running setup.py (path:/tmp/pip-vbC36N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:05:58 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)) 23:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:58 INFO - Running setup.py (path:/tmp/pip-PxmRAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:05:58 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)) 23:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:58 INFO - Running setup.py (path:/tmp/pip-_mqItz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:05:58 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)) 23:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:58 INFO - Running setup.py (path:/tmp/pip-oPomaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:05:58 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)) 23:05:58 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)) 23:05:58 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)) 23:05:58 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)) 23:05:58 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:58 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:00 INFO - Downloading blessings-1.6.tar.gz 23:06:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:00 INFO - Installing collected packages: blessings 23:06:00 INFO - Running setup.py install for blessings 23:06:00 INFO - Successfully installed blessings 23:06:00 INFO - Cleaning up... 23:06:00 INFO - Return code: 0 23:06:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:06:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:06:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:06:00 INFO - Reading from file tmpfile_stdout 23:06:00 INFO - Current package versions: 23:06:00 INFO - argparse == 1.2.1 23:06:00 INFO - blessings == 1.6 23:06:00 INFO - blobuploader == 1.2.4 23:06:00 INFO - docopt == 0.6.1 23:06:00 INFO - manifestparser == 1.1 23:06:00 INFO - mozInstall == 1.12 23:06:00 INFO - mozcrash == 0.16 23:06:00 INFO - mozdebug == 0.1 23:06:00 INFO - mozdevice == 0.48 23:06:00 INFO - mozfile == 1.2 23:06:00 INFO - mozhttpd == 0.7 23:06:00 INFO - mozinfo == 0.9 23:06:00 INFO - mozleak == 0.1 23:06:00 INFO - mozlog == 3.1 23:06:00 INFO - moznetwork == 0.27 23:06:00 INFO - mozprocess == 0.22 23:06:00 INFO - mozprofile == 0.28 23:06:00 INFO - mozrunner == 6.11 23:06:00 INFO - mozscreenshot == 0.1 23:06:00 INFO - mozsystemmonitor == 0.0 23:06:00 INFO - moztest == 0.7 23:06:00 INFO - mozversion == 1.4 23:06:00 INFO - psutil == 3.1.1 23:06:00 INFO - requests == 1.2.3 23:06:00 INFO - wsgiref == 0.1.2 23:06:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:06:00 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')]} 23:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:00 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')]} 23:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:06:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 23:06:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 23:06:00 INFO - Using env: {'DISPLAY': ':0', 23:06:00 INFO - 'HOME': '/home/cltbld', 23:06:00 INFO - 'LANG': 'en_US.UTF-8', 23:06:00 INFO - 'LANGUAGE': 'en_US:en', 23:06:00 INFO - 'LOGNAME': 'cltbld', 23:06:00 INFO - 'MAIL': '/var/mail/cltbld', 23:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:00 INFO - 'MOZ_NO_REMOTE': '1', 23:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:00 INFO - 'NO_EM_RESTART': '1', 23:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:06:00 INFO - 'PWD': '/builds/slave/test-pgo', 23:06:00 INFO - 'SHELL': '/bin/bash', 23:06:00 INFO - 'SHLVL': '1', 23:06:00 INFO - 'TERM': 'linux', 23:06:00 INFO - 'TMOUT': '86400', 23:06:00 INFO - 'USER': 'cltbld', 23:06:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:00 INFO - '_': '/tools/buildbot/bin/python'} 23:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 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)) 23:06:00 INFO - Cleaning up... 23:06:00 INFO - Return code: 0 23:06:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:06:00 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')]} 23:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:00 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')]} 23:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:06:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 23:06:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:06:00 INFO - Using env: {'DISPLAY': ':0', 23:06:00 INFO - 'HOME': '/home/cltbld', 23:06:00 INFO - 'LANG': 'en_US.UTF-8', 23:06:00 INFO - 'LANGUAGE': 'en_US:en', 23:06:00 INFO - 'LOGNAME': 'cltbld', 23:06:00 INFO - 'MAIL': '/var/mail/cltbld', 23:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:00 INFO - 'MOZ_NO_REMOTE': '1', 23:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:00 INFO - 'NO_EM_RESTART': '1', 23:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:06:00 INFO - 'PWD': '/builds/slave/test-pgo', 23:06:00 INFO - 'SHELL': '/bin/bash', 23:06:00 INFO - 'SHLVL': '1', 23:06:00 INFO - 'TERM': 'linux', 23:06:00 INFO - 'TMOUT': '86400', 23:06:00 INFO - 'USER': 'cltbld', 23:06:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:00 INFO - '_': '/tools/buildbot/bin/python'} 23:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:01 INFO - Downloading/unpacking jsonschema 23:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:02 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:03 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:03 INFO - warning: no files found matching '*.txt' 23:06:03 INFO - no previously-included directories found matching 'build' 23:06:03 INFO - no previously-included directories found matching 'dist' 23:06:03 INFO - no previously-included directories found matching '.git*' 23:06:03 INFO - Installing collected packages: jsonschema, functools32 23:06:03 INFO - Running setup.py install for functools32 23:06:03 INFO - warning: no files found matching '*.txt' 23:06:03 INFO - no previously-included directories found matching 'build' 23:06:03 INFO - no previously-included directories found matching 'dist' 23:06:03 INFO - no previously-included directories found matching '.git*' 23:06:03 INFO - Successfully installed jsonschema functools32 23:06:03 INFO - Cleaning up... 23:06:03 INFO - Return code: 0 23:06:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:06:03 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')]} 23:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 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')]} 23:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6496379f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1217630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, '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': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', '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 23:06:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 23:06:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:06:03 INFO - Using env: {'DISPLAY': ':0', 23:06:03 INFO - 'HOME': '/home/cltbld', 23:06:03 INFO - 'LANG': 'en_US.UTF-8', 23:06:03 INFO - 'LANGUAGE': 'en_US:en', 23:06:03 INFO - 'LOGNAME': 'cltbld', 23:06:03 INFO - 'MAIL': '/var/mail/cltbld', 23:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:03 INFO - 'MOZ_NO_REMOTE': '1', 23:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:03 INFO - 'NO_EM_RESTART': '1', 23:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:06:03 INFO - 'PWD': '/builds/slave/test-pgo', 23:06:03 INFO - 'SHELL': '/bin/bash', 23:06:03 INFO - 'SHLVL': '1', 23:06:03 INFO - 'TERM': 'linux', 23:06:03 INFO - 'TMOUT': '86400', 23:06:03 INFO - 'USER': 'cltbld', 23:06:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:03 INFO - '_': '/tools/buildbot/bin/python'} 23:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:03 INFO - Downloading/unpacking flake8 23:06:03 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 23:06:03 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 23:06:03 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 23:06:03 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 23:06:03 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 23:06:03 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 23:06:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:05 INFO - no previously-included directories found matching 'docs/_build' 23:06:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:06 INFO - Running setup.py install for pep8 23:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:06 INFO - no previously-included directories found matching 'docs/_build' 23:06:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:06:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:06 INFO - Cleaning up... 23:06:06 INFO - Return code: 0 23:06:06 INFO - Running post-action listener: _resource_record_post_action 23:06:06 INFO - Running post-action listener: _start_resource_monitoring 23:06:06 INFO - Starting resource monitoring. 23:06:06 INFO - ##### 23:06:06 INFO - ##### Running install step. 23:06:06 INFO - ##### 23:06:06 INFO - Running pre-action listener: _resource_record_pre_action 23:06:06 INFO - Running main action method: install 23:06:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:06:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:06:06 INFO - Reading from file tmpfile_stdout 23:06:06 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:06:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:06:06 INFO - Reading from file tmpfile_stdout 23:06:06 INFO - Output received: 23:06:06 INFO - Usage: mozinstall [options] installer 23:06:06 INFO - Options: 23:06:06 INFO - -h, --help show this help message and exit 23:06:06 INFO - -d DEST, --destination=DEST 23:06:06 INFO - Directory to install application into. [default: 23:06:06 INFO - "/builds/slave/test-pgo"] 23:06:06 INFO - --app=APP Application being installed. [default: firefox] 23:06:06 INFO - mkdir: /builds/slave/test-pgo/build/application 23:06:06 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'] 23:06:06 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 23:06:22 INFO - Reading from file tmpfile_stdout 23:06:22 INFO - Output received: 23:06:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:06:22 INFO - Running post-action listener: _resource_record_post_action 23:06:22 INFO - ##### 23:06:22 INFO - ##### Running run-tests step. 23:06:22 INFO - ##### 23:06:22 INFO - Running pre-action listener: _resource_record_pre_action 23:06:22 INFO - Running main action method: run_tests 23:06:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:06:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:06:22 INFO - Python 2.7.3 23:06:22 INFO - Return code: 0 23:06:22 INFO - grabbing minidump binary from tooltool 23:06:22 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')]} 23:06:22 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 0x12a8840>, '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 0x12156b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:06:22 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 23:06:22 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 23:06:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:22 INFO - Return code: 0 23:06:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:06:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:06:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:06:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:06:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:06:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:06:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:06:23 INFO - Return code: 0 23:06:23 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/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:06:23 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/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 23:06:23 INFO - Using env: {'DISPLAY': ':0', 23:06:23 INFO - 'HOME': '/home/cltbld', 23:06:23 INFO - 'LANG': 'en_US.UTF-8', 23:06:23 INFO - 'LANGUAGE': 'en_US:en', 23:06:23 INFO - 'LOGNAME': 'cltbld', 23:06:23 INFO - 'MAIL': '/var/mail/cltbld', 23:06:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:06:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:23 INFO - 'MOZ_NO_REMOTE': '1', 23:06:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:23 INFO - 'NO_EM_RESTART': '1', 23:06:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:06:23 INFO - 'PWD': '/builds/slave/test-pgo', 23:06:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:06:23 INFO - 'SHELL': '/bin/bash', 23:06:23 INFO - 'SHLVL': '1', 23:06:23 INFO - 'TERM': 'linux', 23:06:23 INFO - 'TMOUT': '86400', 23:06:23 INFO - 'USER': 'cltbld', 23:06:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306', 23:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:23 INFO - '_': '/tools/buildbot/bin/python'} 23:06:23 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/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:06:23 INFO - mozversion application_buildid: 20160123203118 23:06:23 INFO - mozversion application_changeset: c2abac115afa756db2aa05fed2a7491d60093ed3 23:06:23 INFO - mozversion application_display_name: Nightly 23:06:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:23 INFO - mozversion application_name: Firefox 23:06:23 INFO - mozversion application_remotingname: firefox 23:06:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:06:23 INFO - mozversion application_vendor: Mozilla 23:06:23 INFO - mozversion application_version: 46.0a1 23:06:23 INFO - mozversion platform_buildid: 20160123203118 23:06:23 INFO - mozversion platform_changeset: c2abac115afa756db2aa05fed2a7491d60093ed3 23:06:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:06:23 INFO - mozversion platform_version: 46.0a1 23:06:23 INFO - using testdate: 1453619183 23:06:23 INFO - actual date: 1453619183 23:06:23 INFO - starting webserver on 'localhost:54175' 23:06:23 INFO - SUITE-START | Running 3 tests 23:06:23 INFO - TEST-START | dromaeo_css 23:06:23 INFO - operating with platform_type : linux_ 23:06:23 INFO - Initialising browser for dromaeo_css test... 23:06:23 INFO - TEST-INFO | started process 6304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpotLkgP/profile http://localhost:54175/getInfo.html) 23:06:27 INFO - PROCESS | 6304 | 23:06:27 INFO - PROCESS | 6304 | (process:6386): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:06:28 INFO - PROCESS | 6304 | __metrics Screen width/height:1600/1200 23:06:28 INFO - PROCESS | 6304 | colorDepth:24 23:06:28 INFO - PROCESS | 6304 | Browser inner width/height: 1024/697 23:06:28 INFO - PROCESS | 6304 | __metrics 23:06:28 INFO - PROCESS | 6304 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:06:29 INFO - TEST-INFO | 6304: exit 0 23:06:29 INFO - Browser initialized. 23:06:29 INFO - Running cycle 1/1 for dromaeo_css test... 23:06:29 INFO - TEST-INFO | started process 6435 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpotLkgP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:30 INFO - PROCESS | 6435 | 23:06:30 INFO - PROCESS | 6435 | (process:6494): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:06:41 INFO - PROCESS | 6435 | RSS: Main: 151744512 23:06:41 INFO - PROCESS | 6435 | 23:07:30 INFO - PROCESS | 6435 | 1453619250857 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] 23:09:39 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:54175/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54175/tests/dromaeo/cssquery-ext.html) 23:09:40 INFO - PROCESS | 6435 | RSS: Main: 160436224 23:09:40 INFO - PROCESS | 6435 | 23:12:43 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:54175/tests/dromaeo/cssquery-ext.html (next: http://localhost:54175/tests/dromaeo/cssquery-jquery.html) 23:12:43 INFO - PROCESS | 6435 | RSS: Main: 157831168 23:12:43 INFO - PROCESS | 6435 | 23:15:45 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:54175/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54175/tests/dromaeo/cssquery-mootools.html) 23:15:46 INFO - PROCESS | 6435 | RSS: Main: 155852800 23:15:46 INFO - PROCESS | 6435 | 23:18:47 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:54175/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54175/tests/dromaeo/cssquery-prototype.html) 23:18:48 INFO - PROCESS | 6435 | RSS: Main: 153804800 23:18:48 INFO - PROCESS | 6435 | 23:21:50 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:54175/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54175/tests/dromaeo/cssquery-yui.html) 23:21:51 INFO - PROCESS | 6435 | RSS: Main: 154595328 23:21:51 INFO - PROCESS | 6435 | 23:24:53 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:54175/tests/dromaeo/cssquery-yui.html (next: http://localhost:54175/tests/dromaeo/cssquery-dojo.html) 23:24:54 INFO - PROCESS | 6435 | RSS: Main: 158240768 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | __start_tp_report 23:24:54 INFO - PROCESS | 6435 | _x_x_mozilla_page_load 23:24:54 INFO - PROCESS | 6435 | _x_x_mozilla_page_load_details 23:24:54 INFO - PROCESS | 6435 | |i|pagename|runs| 23:24:54 INFO - PROCESS | 6435 | |0;dojo.html;3235.0780027692103;3269.427850126229;3278.6557411471804;3279.147421670365;3301.950470742939;5253.9737301313535;5256.1590145576665;5264.131418315973;5348.786048558058;5349.411564727877;5253.343332083489;5358.089124848775;5420.268263784388;5441.700706461143;5445.856370162271;4597.241455159895;4870.561649451549;4984.975075124619;4989.301497790312;4995.950040499585;4828.71027738335;4902.7058376497525;4905.288733133693;4961.082199793032;4982.9252561211615;4845;4892.584130348942;4895.534924182232;4940.604751619861;4962.702237865739;4889.364382630235;4895.363602731658;4911.4106307243;4917.40991081069;4938.876528086791;4818.325434439182;4889.196469024314;4898.02039592083;4924.285978533128;4969.204927211629;5028.069807085701;5045.091883460976;5074.5432911037815;5085.694858308476;5102.056119617845;5776.249087618625;5827.912581311284;5833.7374818133285;5834.4165583441745;5835.679037652927;5757.309122905278;5793.246877905845;5842.899971660538;5874.706264686792;5910.290765108214;5408.378036525811;5428.4842939920645;5430.619856610078;5436.238926550286;5474.890502189934;5823.068309070529;5861.824145275648;5862.12068189775;5868.794592189338;5895.292564892155;5551.333839939233;5634.85912852182;5638.661680299195;5706.771729130871;5719.742611582489;5767.423257674199;5769.048107062372;5786.826395208151;5788.016037273674;5821.505172060338;5656.208130861683;5674.971625141848;5714.457126572969;5740.54075673945;5744.4829965303325;5588.86027849307;5682.914756278659;5738.340090889517;5781;5912.231409916683;4470.105978804252;4494.280915053576;4500.347449619787;4504.842330518416;4525.864224073283;4004.1190937993597;4013.337799263147;4014.8996275093355;4054.9391759123637;4061.025353915039;5324.7870085196155;5368.570514358842;5370.62405631602;5394.433584473573;5456.781728730806;5750.396208398141;5790.218320526759;5796.21751063601;5798.043322851767;5800.361960184377;5382.165764306539;5438.211459338374;5445.782168713286;5447.073997420448;5452.972735136299;4815.422149342031;4859.222524396079;4885;4946.233333833262;4953.876153096201;6039.728212230372;6069.878602427927;6095.664738439428;6104.847378815565;6117.204763380821;5798.449147330997;5810.273715785527;5851.444112809277;5861.882762344644;5866.765329386777;5929.881402372014;5958.612690175125;5962.07587823888;5984.611000285142;5988.610740301867;5698.401667824819;5764.9711751442655;5783.103618939072;5812.709364531672;5855.092460668603;5823.4467725566;5831.533477321719;5836.912446313394;5839.124131380327;5843.474087332161;5623.353314368736;5680.233168522362;5682.261306030189;5683.602147849776;5691.2032315475035;5581.804636837691;5607.915881261866;5650.180723795109;5660.122680984454;5663.093904975184;5565.332160140809;5609.88780224385;5649.039663257338;5655.066913959316;5667.234923285304;5638.605297629127;5653.886922261449;5740.856478588069;5754.53963682896;5777.9133313001175;5684.857878553069;5724.255846739898;5731.742071606871;5735.713214339183;5739.856503587277 23:24:54 INFO - PROCESS | 6435 | |1;ext.html;529.3885562175686;530.0776648631381;530.7558523079383;551.1539786427833;556.0796881161679;35887.28225435493;35978.999999999935;36097.458538121886;36235.63764362359;36308.455373169425;39532.40701389474;39960.60039399605;39968.400473992915;39971;40244.79877600608;8271.710490132846;8458.619362128687;8509;8512.106228845974;8542.487450752944;8314.251717345467;8474.067852536216;8477.237048665618;8492.617832197535;8534.231919127278;8705.085965973576;8732;8738.388312818106;8749.693760718375;8758.474491530496;8585.356098292621;8608.956955215215;8622.008469026048;8648.394612377137;8714;8483;8588.656453741844;8601.225889669897;8623.09457506959;8647.221750042463;40716;40754.184916301805;40912.59087409118;40951.7952410239;40994.79502602498;2867.3691787806647;2982.9850850745606;3010.804297720641;3263.4778435450453;3567.2009310084677;28293.575596365867;28498.907563443383;28512.28719282014;29038.12885613435;29058.128256152348;3735.3649879520276;3736.645018723217;3799;3883.7087218458446;3936.2810778621297;262742;271018;271378;273251;273634.63182684156;55490.16764748532;55577.444225558036;55722;55967;56415.71792141013;67210.32789672041;68906.310936891;69158;69319.65340173266;69618.65190674014;14637.780433293296;14715;14738.484153054806;14839.480618178311;14891.18098504571;10605;10632.30889992148;10650.57397704083;10688.251822372515;10703.090237329914;21177.15291388358;21407.89296053541;21631.242906498195;21730.782692172877;21865.12539498402;8413.663453461915;8435.451695639764;8536.573171341532;8693.521856297837;8779.912200878038;861.7716305179133;934.1825902335456;998.7153661206521;1078.7518870659635;1089.1444287223142;27594.172174834788;30502.847485762428;30556.23609409738;31205.063848084596;32335.51496727551;927.2767241551601;970.8058388322364;985.4136788610765;993.6770549571419;1020.2857999400301;14688.485902993343;14937.103773773608;14938.850611493963;14976.251187440585;15160.241987900561;371302;374714;375793;375808;377273.47722397954;53666.46333536615;54006.18990715143;54031.18953215705;54161;54371.184432233546;1245.5017992802952;1250.7123361626877;1253.793124134544;1258.3205069262679;1271.0848189303686;24423;25104.37239068965;25256.242312730647;25279.620805687562;25390.873045634653;45876.541234587225;45889.311660324456;46280.768596156806;46322;46502.53497464982;297574;300928;302113;302175;305382;33117;44038.55961440473;44112.33831492466;44836.10327793361;45060.32409513794;39274.022340825846;39283;39557.2088558233;39678.60321396749;40148.799256003535;35489.82255088708;35533.82233088818;36210.63789362178;36701.26597468089;36824.81587592045;37357.62642373541;37449.251014979;37683;38767;39083.21833563256;33465.33069338648;33783.83108084444;33913.83043084769;33967.66032339645;34006.82996585001;30296.09111726652;30762.230944226572;32233;32343.514847276838;32453.837730811196;24651.260462186165;24664.260072197863;24672.25983220506;24984.500309994062;25022.74977250277 23:24:54 INFO - PROCESS | 6435 | |2;jquery.html;366.730453116959;369.92786406650697;375.5493407910508;377.38109500419307;383.5340061824882;14980;16338;16417.67164656706;16947.49157525273;17164.742528862047;10304.639337623184;10422.27044106911;10534.473276336192;10623.15014798816;10646.893531064687;4657.953420465786;4662.300654901758;4794;4802.399700037496;4850.126977144113;4695.436547614291;4715.622750179978;4763.4998325175875;4786.449558300787;4789.712617242959;3695.778253304797;4775.737334446604;4781.258904869734;5191.402988656315;5909.172715819789;5338.412774594792;5873.177755114288;5907.232059832216;5907.88184236315;5931.792387266447;5109.923351149736;5161.561267292247;5165.251038599419;5174.586033117342;5191.740412979374;12310.199837010656;15833.762493562606;19354.903225483922;20132.094055767524;20177.8991105045;1850.5373656585853;1935.5644979879414;2004.8997550122435;2033.8779673219653;2095.1619352259067;8753.956230218871;9066.456012639263;9084.545772711404;9171.633134674672;9451.574679139456;1766.5230387795223;1804.1971322761376;1859.3678149429124;1859.944201673952;1868.3740946782843;55695.72152139214;57255.42744572543;57517.71241143768;58453;59013.7049314755;9268.165865072042;9845.950770246103;10359;10385.688429347132;10411.271211015157;13442.260675662932;13452.5291614793;13475.797863032063;13527.932360338134;13572.93213533926;7404.296591823876;7496.400287976949;7530.096388433423;7538.547687138789;7574.204708505637;7031.8945215821805;7051.153861536648;7148.070750802466;7230.168530618941;7244.130704315516;4243.639290660267;4318.805653745589;4385.6710746694125;4390.846320378771;4435.977820110878;1833.5782769962984;1863.478226096668;1890.9432717018512;1914.9808501914802;2816.7466027178584;823.4770920465428;866.77463859397;898.0736320592423;925.6945208081318;983.852422136671;14429.85570144306;14886.255687215813;15067;15211.239438028055;15472.458463953708;795.3398679096337;798.7523867601062;875.1773333066897;892.9821403571892;951.2390087929629;8529.445586036887;8610;8702;9422.95288523553;9686.951565242129;550508;562859;564534;570112;592347;71471.64264178646;72362;73272.63363683148;74461.25538744651;74889;1095.4084794211037;1111.5053801058452;1112.710695219249;1119.798436281461;1127.5940661361903;14305.21321327337;14427.3507692152;14802.62993425173;15025.699486010437;15140.167290799112;31731.841340793148;32910.17724556905;32970;33505.83247083847;34044.829775850965;37224.62775372212;37432.06419839526;37739.62260377361;38089;38908.221835563694;7236.710531578678;7349.559026458216;7373.77878663641;7473.065866766654;7529.887051694339;3549.272399158218;4302.67729920251;10032;10399.480025998519;11241.437928103725;6740.696668650021;8799.096298221699;9119.817603647758;9121.179093881317;9221.123993220634;9304.581293841658;9433.905660943303;9541.522923853641;9691.418514889128;10000.349977251455;8860.468371897707;9119.954400228222;9122.635094596142;9240.861387079065;9285.07149285066;7268.313792983398;7272.672729727069;7302.196758356683;7327.487075904635;7501.512401693873;8398.370122240734;8626.051134375339;8716.346274029347;8723.825523489622;8802.25180859634 23:24:54 INFO - PROCESS | 6435 | |3;mootools.html;1461.3570029187158;1469.3681716861752;1624.902505849649;1752;1773.4325015994887;7631.771046868603;7792.92207077929;7856.489328193664;7966.60166991651;7992.760217193486;7765.650545725442;7826.413019023582;7850.607469626524;7912.327452166573;7915.8416831663335;2306.08909480755;2360.905563777447;2363.267387109993;2367.550165468564;2369.123424332999;2343.6836027136374;2364.7635236476385;2368.4078980254935;2370.4073981504625;2373.596488596943;2277.430642339415;2295.5638428698576;2298.885055747214;2329.9534009319805;2339.4736184358553;2301.873396963166;2331.195737470587;2336.380859072339;2348.342464110052;2365.2785900300314;2338.695969523968;2343.133040774907;2365.3613524348502;2366.9053237870467;2376.1445879483545;7769.689212431496;7835.138134805167;7842.764717058498;7854.842903141962;7854.921450785476;4821.783019764119;4950.084234416644;4973;4976.950230497721;5018.949810501885;2955.468015757163;3016.457037733207;3066.9725641909986;3077.3691393264326;3082.0445661844674;957.7892863570004;972.4797233480125;998.6005597760953;1013.9746506337327;1029.7425643589104;10836.891631083747;10949.4525273736;10981.560737570408;11001.119910407147;11038.779224415546;4313.223619748475;4443.600075993176;4476.753778542212;4503.684742068024;4518.186726389215;9341.719748407559;9404.717858464257;9473.194778443909;9519.048095190425;9541.2367010639;4909.7790599423115;4936.506349365107;4940.481249468826;4942.654014218971;4946.579540739005;4381.518033016366;4383.452068491439;4395.318725597537;4439.311906654474;4466.3523789050405;3541.3094446583186;3616.3309787689363;3619.221867298491;3628.2924829657964;3650.5619325681087;1153.26191237608;1177.7408970026581;1198.2510930668332;1200.2198570928965;1201.765655697148;1235.6972541727334;1256.5916077274921;1256.7486502699496;1258.8111783232405;1278.3352656618506;7251.347378735939;7262.455315851333;7288.3076107769675;7447.739329123455;7466.141393739789;1006.0773453118702;1032.7160030991538;1120.6301920366259;1122.927009744364;1124.4490199802037;5357.8392648220615;5451.945480545223;5472.480114389126;5559.082751346064;5565.276514053228;9125.36122471434;9372.1565059145;9441.055894410503;9547.570359333846;9794;9142.725718228463;9144.634214631473;9191.218746406497;9211.907880921239;9304.069593040776;7420.740274090381;7459.664315105833;7544.735934242385;7559.924400755922;7566.281203285679;7525.90874323231;7555.433342499225;7619.657115429708;7623.923760762322;7639.847203056019;8593.398462107592;8638.352123590881;8793.252573531321;8924.598393072458;9037.593308301011;8715.869261960948;8886.60010299551;8900.287976961697;8907.688230911886;8943.060978597154;7014.228434872058;7054.929450705427;7065.293470652894;7090;7124.786256412316;7163.892541611985;7166.032585601086;7196.820079498055;7224;7257.983882256594;6507.381798729113;6730.629815360202;6912.654367281716;7183.102112235971;7252.419806415369;6744.494162937897;6751.729930802713;6914.377706006484;6938.965305173442;7138.500304978602;6513.804585862432;6518.869622607616;6548.476121910331;6579.671016449062;6583.0454584086;5945.494632956247;6022.608530445507;6068.241469816273;6085.634861908123;6096.390360963868;5983.970080149571;6008.609440386361;6053.3946605339115;6054.90917636227;6089.147519347206 23:24:54 INFO - PROCESS | 6435 | |4;prototype.html;347.16506801143254;350.44804433017987;353.00628730124697;355.31601666791454;358.11188253132246;6172.4444799968;6193.163922870411;6215.347388524207;6272.059191121329;6399.648019358933;6185;6195.163652906856;6200.1629779979685;6233.1585235993125;6254.124422580842;4754.881127971794;4805.399325084364;4810.639202059842;4816.277558366238;4817.0847538967655;4784.234522476405;4809.615230781546;4816.44610869751;4822.059698358821;4823.734694591796;4686.27362758773;4749.810007599692;4779.545943135397;4796.472388037313;4799.880002999918;4762.809487620491;4768.403949506312;4773.928391074137;4779.020300838337;4782.30656554801;4137;4145.357469592218;4162.354835000579;4167.708260421772;4173.061061261223;5925.762969481216;5932.228810254639;5938.673372964486;5942.673152976585;5955.583109182316;5438.83683489496;5550.47270509301;5568.638038527482;5571.832845014656;5576.302962129734;6633.734650613969;6656.467482601381;6669.333066693341;6670.533062685614;6678.398944095006;4598.724076555417;4606.516315786827;4614.746188959606;4618.630509559227;4620.722756634613;6681.732730690766;6780.525363224576;6879.3120687931305;6902.206246281692;6924.169099707967;4649;4657.580817726421;4658.860234192912;4659.114768194032;4664.230401983635;4712.2224832902875;4715.174844402284;4728.0543891221205;4740.407449068866;4745.193317136095;5491.368492623399;5501.339839219239;5505.311836020497;5510.8071217507995;5540.750666220029;6536.967315163393;6626.834329141713;6638.734450621921;6641.1366522352755;6642.070110184578;1609.1069456451548;1628.9185540722917;1636.468147851929;1637.263231545809;1658.2537857963964;1074.1299547366657;1076.8761592416815;1078.5577913055608;1086.739182596187;1095.1239008792934;6145.324014358417;6250.499960003189;6296.275928268308;6304.621722696653;6306.590071645328;6688.799336019927;6727.596344219264;6765.255821859591;6778.93221067783;6784.864302713918;6124.540659450559;6292.937070629327;6307.211598550181;6330.651814150266;6368.235811702625;3662.9450558241647;3665.395209790355;3672.2288319453214;3682.5028621135802;3697.4084146536425;7079;7086.468514861406;7103.644817759091;7105.89341159883;7120.92879071213;6735.696893639798;6864.725410983605;6885.173779146535;6919.031335613018;6928.930710692828;7047.506674532836;7070.540414873017;7104.43164546835;7125.964370178116;7148.213696493382;6733.653269346052;6770.1537307836525;6791.626460544718;6820.9086546152375;6908.792736217922;6663.033860090357;6810.114685090906;6850.280720524273;6868.313168683092;6871.381575658214;7142.142942846892;7176.067111275501;7180.594500842276;7225.060742103493;7225.674844631899;4687.39063921688;4737.360456338351;4741.359916411378;4744.691595046311;4748.406449193851;6700.966495167493;6894.345357114356;6915.688794004182;6919.515633905779;6937.202221744362;6740.898886516804;6762.932370676231;6776.695048722918;6795.422389096982;6796.694148763218;6728.932710673026;6744.156980377453;6776.491763117884;6832.897506537505;6845.452363810784;6521.4130728232785;6602.042703808017;6612.867742645024;6633.668316584248;6676.6995485202315;6747.696353664195;6764.188297404146;6795.456363491007;6842.178938527409;6860.279670634512;6487.513436492188;6623.006549017493;6628.171478565179;6635;6644.235912869888 23:24:54 INFO - PROCESS | 6435 | |5;yui.html;734.8346622010047;780.5745868501663;792.3146478296276;812.9227723366282;834.0991728932752;12739;12757.744845103103;12793;12827.486900523967;12910;11477.483513241903;11568.363739994318;11574.53701851927;11600.709982250426;11601.3039217647;768.7117331000875;771.7877583664481;775.1357236681088;781.6443518199205;803.7789607857827;780.8672525670621;782.7925599716051;783.4515838912755;784.3685832904509;785.0736131365015;829.0755807274875;831.1231650608605;831.2726364431123;831.5468069901918;836.188896770135;826.396730386821;826.921442462965;827.4786884262905;827.4828232354778;831.3349320543541;608.5101493297893;608.9056196289582;609.5489337889929;611.9816405507842;612.3142080869454;12703.110782245247;12731.172473789175;12774.297413642245;12810.80783788244;12843.357832108451;11997.880021199764;12023.63929082129;12237.877621223763;12322.260664360077;12366.938165309115;10130.189584833195;10186.28695991281;10368.637097701545;10369.585216591402;10506.054455099002;3491.5635545556806;3579;3619.819009049537;3655.1775850433705;3691.7969511676847;48076;48427.515724842655;48634.51365486335;49187;49351;9564.426134431957;9684.806303873884;9698.51507424626;9725.124738773544;9773.657921972697;15537.689246215012;15742;15749.291281892343;15888.126153061692;17426.912865435846;7039.436845052383;7274.30894065063;7343.816404589928;7353.264673532604;7442.106947166375;4087.080406908422;4199.853005144805;4263.850765223202;4266.360045993126;4296.398504209413;3216.630087539916;3225.53229781685;3233.951490727641;3245.659205783406;3246.6753324667816;586.5805948746666;594.337313895004;604.4439116013278;609.7103875659027;622.8069298517474;556.4852511426914;646.208379799272;646.9094326794252;701.7824474412948;707.1620130145691;7885.580595492866;8197.34421246299;8539.74380768578;8578.485290882441;8634.481931084156;569.7009070238158;648.4488185042676;666.8766278238444;668.7425341243656;736.1423941108656;3744.5132132823105;3897.8830635080994;3971.940420893689;3995.680345572347;4079.7960101995377;57467.42532574704;57775;58071.4192858066;58423.70788146032;58442.4155758437;51206.48793512092;51981.48018519842;52260.738696306275;52528.212076818876;52655.21017184745;46365.5363446368;47457.52542474531;47572;47836;47908;7807.921920780719;7901.328387086932;7989.800254993672;8042.276195142465;8232.17678232172;33473.330533389686;33973.49039764455;34287.65712342845;35361.64638353584;35538.64461355354;40890.38664419977;41333.58666413418;45222.09555808931;45449;45556.31665524953;9892.653757118467;9901.950490247502;9904.752381190528;9949.900500995187;9977.501124943868;11504.367259800456;11821.881781182077;11971.10216733731;12623.116381853182;12699.047571432364;10177.491125443847;10298.691039268833;10746.570137194425;10971.561137554409;11090.889091108986;9897.406155630686;10501.579936802442;10578.735531611772;10923.56305747793;10962.287451315638;9611.406289532913;9946;10770.623028193975;11215.158863085138;11357.943210283896;9016.909830901606;9047.68333108338;9215.44707317563;9280.489573073546;9499.952500237454;8580.14198580137;8755.737327880173;8823.823523529365;8868.822623547621;9451.621935122517 23:24:54 INFO - PROCESS | 6435 | __end_tp_report 23:24:54 INFO - PROCESS | 6435 | __start_cc_report 23:24:54 INFO - PROCESS | 6435 | _x_x_mozilla_cycle_collect,321 23:24:54 INFO - PROCESS | 6435 | __end_cc_report 23:24:54 INFO - PROCESS | 6435 | __startTimestamp1453620294153__endTimestamp 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | ------- Summary: start ------- 23:24:54 INFO - PROCESS | 6435 | Number of tests: 6 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | [#0] dojo.html Cycles:165 Average:5372.08 Median:5634.86 stddev:598.05 (10.6%) stddev-sans-first:575.90 23:24:54 INFO - PROCESS | 6435 | Values: 3235.1 3269.4 3278.7 3279.1 3302.0 5254.0 5256.2 5264.1 5348.8 5349.4 5253.3 5358.1 5420.3 5441.7 5445.9 4597.2 4870.6 4985.0 4989.3 4996.0 4828.7 4902.7 4905.3 4961.1 4982.9 4845.0 4892.6 4895.5 4940.6 4962.7 4889.4 4895.4 4911.4 4917.4 4938.9 4818.3 4889.2 4898.0 4924.3 4969.2 5028.1 5045.1 5074.5 5085.7 5102.1 5776.2 5827.9 5833.7 5834.4 5835.7 5757.3 5793.2 5842.9 5874.7 5910.3 5408.4 5428.5 5430.6 5436.2 5474.9 5823.1 5861.8 5862.1 5868.8 5895.3 5551.3 5634.9 5638.7 5706.8 5719.7 5767.4 5769.0 5786.8 5788.0 5821.5 5656.2 5675.0 5714.5 5740.5 5744.5 5588.9 5682.9 5738.3 5781.0 5912.2 4470.1 4494.3 4500.3 4504.8 4525.9 4004.1 4013.3 4014.9 4054.9 4061.0 5324.8 5368.6 5370.6 5394.4 5456.8 5750.4 5790.2 5796.2 5798.0 5800.4 5382.2 5438.2 5445.8 5447.1 5453.0 4815.4 4859.2 4885.0 4946.2 4953.9 6039.7 6069.9 6095.7 6104.8 6117.2 5798.4 5810.3 5851.4 5861.9 5866.8 5929.9 5958.6 5962.1 5984.6 5988.6 5698.4 5765.0 5783.1 5812.7 5855.1 5823.4 5831.5 5836.9 5839.1 5843.5 5623.4 5680.2 5682.3 5683.6 5691.2 5581.8 5607.9 5650.2 5660.1 5663.1 5565.3 5609.9 5649.0 5655.1 5667.2 5638.6 5653.9 5740.9 5754.5 5777.9 5684.9 5724.3 5731.7 5735.7 5739.9 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | [#1] ext.html Cycles:180 Average:48428.08 Median:375800.50 stddev:83656.85 (22.3%) stddev-sans-first:83814.23 23:24:54 INFO - PROCESS | 6435 | Values: 529.4 530.1 530.8 551.2 556.1 35887.3 35979.0 36097.5 36235.6 36308.5 39532.4 39960.6 39968.4 39971.0 40244.8 8271.7 8458.6 8509.0 8512.1 8542.5 8314.3 8474.1 8477.2 8492.6 8534.2 8705.1 8732.0 8738.4 8749.7 8758.5 8585.4 8609.0 8622.0 8648.4 8714.0 8483.0 8588.7 8601.2 8623.1 8647.2 40716.0 40754.2 40912.6 40951.8 40994.8 2867.4 2983.0 3010.8 3263.5 3567.2 28293.6 28498.9 28512.3 29038.1 29058.1 3735.4 3736.6 3799.0 3883.7 3936.3 262742.0 271018.0 271378.0 273251.0 273634.6 55490.2 55577.4 55722.0 55967.0 56415.7 67210.3 68906.3 69158.0 69319.7 69618.7 14637.8 14715.0 14738.5 14839.5 14891.2 10605.0 10632.3 10650.6 10688.3 10703.1 21177.2 21407.9 21631.2 21730.8 21865.1 8413.7 8435.5 8536.6 8693.5 8779.9 861.8 934.2 998.7 1078.8 1089.1 27594.2 30502.8 30556.2 31205.1 32335.5 927.3 970.8 985.4 993.7 1020.3 14688.5 14937.1 14938.9 14976.3 15160.2 371302.0 374714.0 375793.0 375808.0 377273.5 53666.5 54006.2 54031.2 54161.0 54371.2 1245.5 1250.7 1253.8 1258.3 1271.1 24423.0 25104.4 25256.2 25279.6 25390.9 45876.5 45889.3 46280.8 46322.0 46502.5 297574.0 300928.0 302113.0 302175.0 305382.0 33117.0 44038.6 44112.3 44836.1 45060.3 39274.0 39283.0 39557.2 39678.6 40148.8 35489.8 35533.8 36210.6 36701.3 36824.8 37357.6 37449.3 37683.0 38767.0 39083.2 33465.3 33783.8 33913.8 33967.7 34006.8 30296.1 30762.2 32233.0 32343.5 32453.8 24651.3 24664.3 24672.3 24984.5 25022.7 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | [#2] jquery.html Cycles:180 Average:27715.67 Median:4826.26 stddev:92878.05 (1924.4%) stddev-sans-first:93115.90 23:24:54 INFO - PROCESS | 6435 | Values: 366.7 369.9 375.5 377.4 383.5 14980.0 16338.0 16417.7 16947.5 17164.7 10304.6 10422.3 10534.5 10623.2 10646.9 4658.0 4662.3 4794.0 4802.4 4850.1 4695.4 4715.6 4763.5 4786.4 4789.7 3695.8 4775.7 4781.3 5191.4 5909.2 5338.4 5873.2 5907.2 5907.9 5931.8 5109.9 5161.6 5165.3 5174.6 5191.7 12310.2 15833.8 19354.9 20132.1 20177.9 1850.5 1935.6 2004.9 2033.9 2095.2 8754.0 9066.5 9084.5 9171.6 9451.6 1766.5 1804.2 1859.4 1859.9 1868.4 55695.7 57255.4 57517.7 58453.0 59013.7 9268.2 9846.0 10359.0 10385.7 10411.3 13442.3 13452.5 13475.8 13527.9 13572.9 7404.3 7496.4 7530.1 7538.5 7574.2 7031.9 7051.2 7148.1 7230.2 7244.1 4243.6 4318.8 4385.7 4390.8 4436.0 1833.6 1863.5 1890.9 1915.0 2816.7 823.5 866.8 898.1 925.7 983.9 14429.9 14886.3 15067.0 15211.2 15472.5 795.3 798.8 875.2 893.0 951.2 8529.4 8610.0 8702.0 9423.0 9687.0 550508.0 562859.0 564534.0 570112.0 592347.0 71471.6 72362.0 73272.6 74461.3 74889.0 1095.4 1111.5 1112.7 1119.8 1127.6 14305.2 14427.4 14802.6 15025.7 15140.2 31731.8 32910.2 32970.0 33505.8 34044.8 37224.6 37432.1 37739.6 38089.0 38908.2 7236.7 7349.6 7373.8 7473.1 7529.9 3549.3 4302.7 10032.0 10399.5 11241.4 6740.7 8799.1 9119.8 9121.2 9221.1 9304.6 9433.9 9541.5 9691.4 10000.3 8860.5 9120.0 9122.6 9240.9 9285.1 7268.3 7272.7 7302.2 7327.5 7501.5 8398.4 8626.1 8716.3 8723.8 8802.3 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | [#3] mootools.html Cycles:180 Average:5504.82 Median:6038.00 stddev:2848.54 (47.2%) stddev-sans-first:2840.32 23:24:54 INFO - PROCESS | 6435 | Values: 1461.4 1469.4 1624.9 1752.0 1773.4 7631.8 7792.9 7856.5 7966.6 7992.8 7765.7 7826.4 7850.6 7912.3 7915.8 2306.1 2360.9 2363.3 2367.6 2369.1 2343.7 2364.8 2368.4 2370.4 2373.6 2277.4 2295.6 2298.9 2330.0 2339.5 2301.9 2331.2 2336.4 2348.3 2365.3 2338.7 2343.1 2365.4 2366.9 2376.1 7769.7 7835.1 7842.8 7854.8 7854.9 4821.8 4950.1 4973.0 4977.0 5018.9 2955.5 3016.5 3067.0 3077.4 3082.0 957.8 972.5 998.6 1014.0 1029.7 10836.9 10949.5 10981.6 11001.1 11038.8 4313.2 4443.6 4476.8 4503.7 4518.2 9341.7 9404.7 9473.2 9519.0 9541.2 4909.8 4936.5 4940.5 4942.7 4946.6 4381.5 4383.5 4395.3 4439.3 4466.4 3541.3 3616.3 3619.2 3628.3 3650.6 1153.3 1177.7 1198.3 1200.2 1201.8 1235.7 1256.6 1256.7 1258.8 1278.3 7251.3 7262.5 7288.3 7447.7 7466.1 1006.1 1032.7 1120.6 1122.9 1124.4 5357.8 5451.9 5472.5 5559.1 5565.3 9125.4 9372.2 9441.1 9547.6 9794.0 9142.7 9144.6 9191.2 9211.9 9304.1 7420.7 7459.7 7544.7 7559.9 7566.3 7525.9 7555.4 7619.7 7623.9 7639.8 8593.4 8638.4 8793.3 8924.6 9037.6 8715.9 8886.6 8900.3 8907.7 8943.1 7014.2 7054.9 7065.3 7090.0 7124.8 7163.9 7166.0 7196.8 7224.0 7258.0 6507.4 6730.6 6912.7 7183.1 7252.4 6744.5 6751.7 6914.4 6939.0 7138.5 6513.8 6518.9 6548.5 6579.7 6583.0 5945.5 6022.6 6068.2 6085.6 6096.4 5984.0 6008.6 6053.4 6054.9 6089.1 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | [#4] prototype.html Cycles:180 Average:5554.50 Median:6263.09 stddev:1685.79 (26.9%) stddev-sans-first:1644.59 23:24:54 INFO - PROCESS | 6435 | Values: 347.2 350.4 353.0 355.3 358.1 6172.4 6193.2 6215.3 6272.1 6399.6 6185.0 6195.2 6200.2 6233.2 6254.1 4754.9 4805.4 4810.6 4816.3 4817.1 4784.2 4809.6 4816.4 4822.1 4823.7 4686.3 4749.8 4779.5 4796.5 4799.9 4762.8 4768.4 4773.9 4779.0 4782.3 4137.0 4145.4 4162.4 4167.7 4173.1 5925.8 5932.2 5938.7 5942.7 5955.6 5438.8 5550.5 5568.6 5571.8 5576.3 6633.7 6656.5 6669.3 6670.5 6678.4 4598.7 4606.5 4614.7 4618.6 4620.7 6681.7 6780.5 6879.3 6902.2 6924.2 4649.0 4657.6 4658.9 4659.1 4664.2 4712.2 4715.2 4728.1 4740.4 4745.2 5491.4 5501.3 5505.3 5510.8 5540.8 6537.0 6626.8 6638.7 6641.1 6642.1 1609.1 1628.9 1636.5 1637.3 1658.3 1074.1 1076.9 1078.6 1086.7 1095.1 6145.3 6250.5 6296.3 6304.6 6306.6 6688.8 6727.6 6765.3 6778.9 6784.9 6124.5 6292.9 6307.2 6330.7 6368.2 3662.9 3665.4 3672.2 3682.5 3697.4 7079.0 7086.5 7103.6 7105.9 7120.9 6735.7 6864.7 6885.2 6919.0 6928.9 7047.5 7070.5 7104.4 7126.0 7148.2 6733.7 6770.2 6791.6 6820.9 6908.8 6663.0 6810.1 6850.3 6868.3 6871.4 7142.1 7176.1 7180.6 7225.1 7225.7 4687.4 4737.4 4741.4 4744.7 4748.4 6701.0 6894.3 6915.7 6919.5 6937.2 6740.9 6762.9 6776.7 6795.4 6796.7 6728.9 6744.2 6776.5 6832.9 6845.5 6521.4 6602.0 6612.9 6633.7 6676.7 6747.7 6764.2 6795.5 6842.2 6860.3 6487.5 6623.0 6628.2 6635.0 6644.2 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - PROCESS | 6435 | [#5] yui.html Cycles:180 Average:13530.68 Median:52591.71 stddev:16109.91 (30.6%) stddev-sans-first:16126.44 23:24:54 INFO - PROCESS | 6435 | Values: 734.8 780.6 792.3 812.9 834.1 12739.0 12757.7 12793.0 12827.5 12910.0 11477.5 11568.4 11574.5 11600.7 11601.3 768.7 771.8 775.1 781.6 803.8 780.9 782.8 783.5 784.4 785.1 829.1 831.1 831.3 831.5 836.2 826.4 826.9 827.5 827.5 831.3 608.5 608.9 609.5 612.0 612.3 12703.1 12731.2 12774.3 12810.8 12843.4 11997.9 12023.6 12237.9 12322.3 12366.9 10130.2 10186.3 10368.6 10369.6 10506.1 3491.6 3579.0 3619.8 3655.2 3691.8 48076.0 48427.5 48634.5 49187.0 49351.0 9564.4 9684.8 9698.5 9725.1 9773.7 15537.7 15742.0 15749.3 15888.1 17426.9 7039.4 7274.3 7343.8 7353.3 7442.1 4087.1 4199.9 4263.9 4266.4 4296.4 3216.6 3225.5 3234.0 3245.7 3246.7 586.6 594.3 604.4 609.7 622.8 556.5 646.2 646.9 701.8 707.2 7885.6 8197.3 8539.7 8578.5 8634.5 569.7 648.4 666.9 668.7 736.1 3744.5 3897.9 3971.9 3995.7 4079.8 57467.4 57775.0 58071.4 58423.7 58442.4 51206.5 51981.5 52260.7 52528.2 52655.2 46365.5 47457.5 47572.0 47836.0 47908.0 7807.9 7901.3 7989.8 8042.3 8232.2 33473.3 33973.5 34287.7 35361.6 35538.6 40890.4 41333.6 45222.1 45449.0 45556.3 9892.7 9902.0 9904.8 9949.9 9977.5 11504.4 11821.9 11971.1 12623.1 12699.0 10177.5 10298.7 10746.6 10971.6 11090.9 9897.4 10501.6 10578.7 10923.6 10962.3 9611.4 9946.0 10770.6 11215.2 11357.9 9016.9 9047.7 9215.4 9280.5 9500.0 8580.1 8755.7 8823.8 8868.8 9451.6 23:24:54 INFO - PROCESS | 6435 | -------- Summary: end -------- 23:24:54 INFO - PROCESS | 6435 | 23:24:54 INFO - TEST-INFO | 6435: exit 0 23:24:54 INFO - TEST-OK | dromaeo_css | took 1110822ms 23:24:54 INFO - TEST-START | kraken 23:24:54 INFO - operating with platform_type : linux_ 23:24:54 INFO - Initialising browser for kraken test... 23:24:54 INFO - TEST-INFO | started process 6680 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOZ8TR4/profile http://localhost:54175/getInfo.html) 23:24:58 INFO - PROCESS | 6680 | 23:24:58 INFO - PROCESS | 6680 | (process:6755): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:24:59 INFO - PROCESS | 6680 | __metrics Screen width/height:1600/1200 23:24:59 INFO - PROCESS | 6680 | colorDepth:24 23:24:59 INFO - PROCESS | 6680 | Browser inner width/height: 1024/697 23:24:59 INFO - PROCESS | 6680 | __metrics 23:24:59 INFO - PROCESS | 6680 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:25:00 INFO - TEST-INFO | 6680: exit 0 23:25:00 INFO - Browser initialized. 23:25:00 INFO - Running cycle 1/1 for kraken test... 23:25:00 INFO - TEST-INFO | started process 6804 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOZ8TR4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:01 INFO - PROCESS | 6804 | 23:25:01 INFO - PROCESS | 6804 | (process:6863): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:11 INFO - PROCESS | 6804 | RSS: Main: 151613440 23:25:11 INFO - PROCESS | 6804 | 23:25:14 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54175/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:15 INFO - PROCESS | 6804 | RSS: Main: 155938816 23:25:15 INFO - PROCESS | 6804 | 23:25:17 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54175/tests/kraken/driver.html?testName=audio-dft) 23:25:18 INFO - PROCESS | 6804 | RSS: Main: 158425088 23:25:18 INFO - PROCESS | 6804 | 23:25:21 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54175/tests/kraken/driver.html?testName=audio-fft) 23:25:21 INFO - PROCESS | 6804 | RSS: Main: 153030656 23:25:21 INFO - PROCESS | 6804 | 23:25:23 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54175/tests/kraken/driver.html?testName=audio-oscillator) 23:25:24 INFO - PROCESS | 6804 | RSS: Main: 152481792 23:25:24 INFO - PROCESS | 6804 | 23:25:26 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54175/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:25:27 INFO - PROCESS | 6804 | RSS: Main: 153886720 23:25:27 INFO - PROCESS | 6804 | 23:25:30 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54175/tests/kraken/driver.html?testName=imaging-darkroom) 23:25:30 INFO - PROCESS | 6804 | RSS: Main: 152985600 23:25:30 INFO - PROCESS | 6804 | 23:25:34 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54175/tests/kraken/driver.html?testName=imaging-desaturate) 23:25:34 INFO - PROCESS | 6804 | RSS: Main: 153567232 23:25:34 INFO - PROCESS | 6804 | 23:25:37 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54175/tests/kraken/driver.html?testName=json-parse-financial) 23:25:38 INFO - PROCESS | 6804 | RSS: Main: 153980928 23:25:38 INFO - PROCESS | 6804 | 23:25:39 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54175/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:25:40 INFO - PROCESS | 6804 | RSS: Main: 153440256 23:25:40 INFO - PROCESS | 6804 | 23:25:42 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:25:43 INFO - PROCESS | 6804 | RSS: Main: 154320896 23:25:43 INFO - PROCESS | 6804 | 23:25:45 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:25:45 INFO - PROCESS | 6804 | RSS: Main: 154066944 23:25:45 INFO - PROCESS | 6804 | 23:25:48 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:25:48 INFO - PROCESS | 6804 | RSS: Main: 154939392 23:25:48 INFO - PROCESS | 6804 | 23:25:51 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:25:51 INFO - PROCESS | 6804 | RSS: Main: 154333184 23:25:51 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | Cycle 1(1): loaded http://localhost:54175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54175/tests/kraken/driver.html?testName=ai-astar) 23:25:53 INFO - PROCESS | 6804 | RSS: Main: 154341376 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | __start_tp_report 23:25:53 INFO - PROCESS | 6804 | _x_x_mozilla_page_load 23:25:53 INFO - PROCESS | 6804 | _x_x_mozilla_page_load_details 23:25:53 INFO - PROCESS | 6804 | |i|pagename|runs| 23:25:53 INFO - PROCESS | 6804 | |0;ai-astar;112;105;111;110;109;122;110;111;111;110 23:25:53 INFO - PROCESS | 6804 | |1;audio-beat-detection;150;135;158;165;129;146;152;137;166;124 23:25:53 INFO - PROCESS | 6804 | |2;audio-dft;163;163;162;164;162;162;162;168;168;163 23:25:53 INFO - PROCESS | 6804 | |3;audio-fft;73;73;75;74;74;153;79;73;74;72 23:25:53 INFO - PROCESS | 6804 | |4;audio-oscillator;96;97;147;96;98;96;139;96;97;143 23:25:53 INFO - PROCESS | 6804 | |5;imaging-gaussian-blur;110;109;110;110;111;110;110;110;110;111 23:25:53 INFO - PROCESS | 6804 | |6;imaging-darkroom;147;146;147;146;146;147;147;146;147;148 23:25:53 INFO - PROCESS | 6804 | |7;imaging-desaturate;96;97;97;96;97;97;96;96;96;96 23:25:53 INFO - PROCESS | 6804 | |8;json-parse-financial;60;60;61;60;60;60;60;63;78;58 23:25:53 INFO - PROCESS | 6804 | |9;json-stringify-tinderbox;68;69;73;69;75;70;69;68;69;68 23:25:53 INFO - PROCESS | 6804 | |10;stanford-crypto-aes;84;82;95;85;88;87;89;84;86;85 23:25:53 INFO - PROCESS | 6804 | |11;stanford-crypto-ccm;115;120;115;118;113;121;122;123;114;120 23:25:53 INFO - PROCESS | 6804 | |12;stanford-crypto-pbkdf2;138;142;153;156;142;130;145;141;143;141 23:25:53 INFO - PROCESS | 6804 | |13;stanford-crypto-sha256-iterative;66;69;65;68;67;67;68;66;68;70 23:25:53 INFO - PROCESS | 6804 | __end_tp_report 23:25:53 INFO - PROCESS | 6804 | __start_cc_report 23:25:53 INFO - PROCESS | 6804 | _x_x_mozilla_cycle_collect,738 23:25:53 INFO - PROCESS | 6804 | __end_cc_report 23:25:53 INFO - PROCESS | 6804 | __startTimestamp1453620353782__endTimestamp 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | ------- Summary: start ------- 23:25:53 INFO - PROCESS | 6804 | Number of tests: 14 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:4.28 (3.9%) stddev-sans-first:4.53 23:25:53 INFO - PROCESS | 6804 | Values: 112.0 105.0 111.0 110.0 109.0 122.0 110.0 111.0 111.0 110.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.00 stddev:14.65 (9.7%) stddev-sans-first:15.47 23:25:53 INFO - PROCESS | 6804 | Values: 150.0 135.0 158.0 165.0 129.0 146.0 152.0 137.0 166.0 124.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.36 (1.4%) stddev-sans-first:2.49 23:25:53 INFO - PROCESS | 6804 | Values: 163.0 163.0 162.0 164.0 162.0 162.0 162.0 168.0 168.0 163.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.00 stddev:25.02 (33.8%) stddev-sans-first:26.32 23:25:53 INFO - PROCESS | 6804 | Values: 73.0 73.0 75.0 74.0 74.0 153.0 79.0 73.0 74.0 72.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:22.52 (23.5%) stddev-sans-first:23.26 23:25:53 INFO - PROCESS | 6804 | Values: 96.0 97.0 147.0 96.0 98.0 96.0 139.0 96.0 97.0 143.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:25:53 INFO - PROCESS | 6804 | Values: 110.0 109.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 111.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:25:53 INFO - PROCESS | 6804 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 148.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:25:53 INFO - PROCESS | 6804 | Values: 96.0 97.0 97.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:60.00 stddev:5.75 (9.6%) stddev-sans-first:6.06 23:25:53 INFO - PROCESS | 6804 | Values: 60.0 60.0 61.0 60.0 60.0 60.0 60.0 63.0 78.0 58.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.00 stddev:2.35 (3.4%) stddev-sans-first:2.40 23:25:53 INFO - PROCESS | 6804 | Values: 68.0 69.0 73.0 69.0 75.0 70.0 69.0 68.0 69.0 68.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:3.63 (4.2%) stddev-sans-first:3.73 23:25:53 INFO - PROCESS | 6804 | Values: 84.0 82.0 95.0 85.0 88.0 87.0 89.0 84.0 86.0 85.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:120.00 stddev:3.60 (3.0%) stddev-sans-first:3.64 23:25:53 INFO - PROCESS | 6804 | Values: 115.0 120.0 115.0 118.0 113.0 121.0 122.0 123.0 114.0 120.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:142.50 stddev:7.28 (5.1%) stddev-sans-first:7.48 23:25:53 INFO - PROCESS | 6804 | Values: 138.0 142.0 153.0 156.0 142.0 130.0 145.0 141.0 143.0 141.0 23:25:53 INFO - PROCESS | 6804 | 23:25:53 INFO - PROCESS | 6804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.51 23:25:53 INFO - PROCESS | 6804 | Values: 66.0 69.0 65.0 68.0 67.0 67.0 68.0 66.0 68.0 70.0 23:25:53 INFO - PROCESS | 6804 | -------- Summary: end -------- 23:25:53 INFO - PROCESS | 6804 | 23:25:54 INFO - TEST-INFO | 6804: exit 0 23:25:54 INFO - TEST-OK | kraken | took 60010ms 23:25:54 INFO - TEST-START | v8_7 23:25:54 INFO - operating with platform_type : linux_ 23:25:54 INFO - Initialising browser for v8_7 test... 23:25:54 INFO - TEST-INFO | started process 7091 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgQYB7W/profile http://localhost:54175/getInfo.html) 23:25:58 INFO - PROCESS | 7091 | 23:25:58 INFO - PROCESS | 7091 | (process:7167): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:59 INFO - PROCESS | 7091 | __metrics Screen width/height:1600/1200 23:25:59 INFO - PROCESS | 7091 | colorDepth:24 23:25:59 INFO - PROCESS | 7091 | Browser inner width/height: 1024/697 23:25:59 INFO - PROCESS | 7091 | __metrics 23:25:59 INFO - PROCESS | 7091 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:26:00 INFO - TEST-INFO | 7091: exit 0 23:26:00 INFO - Browser initialized. 23:26:00 INFO - Running cycle 1/1 for v8_7 test... 23:26:00 INFO - TEST-INFO | started process 7217 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgQYB7W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:26:01 INFO - PROCESS | 7217 | 23:26:01 INFO - PROCESS | 7217 | (process:7277): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:26:11 INFO - PROCESS | 7217 | RSS: Main: 150183936 23:26:11 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | Cycle 1(1): loaded http://localhost:54175/tests/v8_7/run.html (next: http://localhost:54175/tests/v8_7/run.html) 23:26:34 INFO - PROCESS | 7217 | RSS: Main: 152018944 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | __start_tp_report 23:26:34 INFO - PROCESS | 7217 | _x_x_mozilla_page_load 23:26:34 INFO - PROCESS | 7217 | _x_x_mozilla_page_load_details 23:26:34 INFO - PROCESS | 7217 | |i|pagename|runs| 23:26:34 INFO - PROCESS | 7217 | |0;Richards;167.95431642593215 23:26:34 INFO - PROCESS | 7217 | |1;DeltaBlue;189.465706707086 23:26:34 INFO - PROCESS | 7217 | |2;Encrypt;279.56388034665923 23:26:34 INFO - PROCESS | 7217 | |3;Decrypt;5256.544502617801 23:26:34 INFO - PROCESS | 7217 | |4;RayTrace;1066.0980810234541 23:26:34 INFO - PROCESS | 7217 | |5;Earley;688.2312456985547 23:26:34 INFO - PROCESS | 7217 | |6;Boyer;12280.487804878048 23:26:34 INFO - PROCESS | 7217 | |7;RegExp;41420 23:26:34 INFO - PROCESS | 7217 | |8;Splay;585.480093676815 23:26:34 INFO - PROCESS | 7217 | |9;NavierStokes;4864.077669902913 23:26:34 INFO - PROCESS | 7217 | __end_tp_report 23:26:34 INFO - PROCESS | 7217 | __startTimestamp1453620394531__endTimestamp 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | ------- Summary: start ------- 23:26:34 INFO - PROCESS | 7217 | Number of tests: 10 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 168.0 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#1] DeltaBlue Cycles:1 Average:189.47 Median:189.47 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 189.5 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 279.6 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 5256.5 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 1066.1 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#5] Earley Cycles:1 Average:688.23 Median:688.23 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 688.2 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 12280.5 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#7] RegExp Cycles:1 Average:41420.00 Median:41420.00 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 41420.0 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#8] Splay Cycles:1 Average:585.48 Median:585.48 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 585.5 23:26:34 INFO - PROCESS | 7217 | 23:26:34 INFO - PROCESS | 7217 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 23:26:34 INFO - PROCESS | 7217 | Values: 4864.1 23:26:34 INFO - PROCESS | 7217 | -------- Summary: end -------- 23:26:34 INFO - PROCESS | 7217 | 23:26:35 INFO - TEST-INFO | 7217: exit 0 23:26:35 INFO - TEST-OK | v8_7 | took 40654ms 23:26:35 INFO - SUITE-END | took 1211s 23:26:35 INFO - Completed test suite (00:20:11) 23:26:35 INFO - Working with test: dromaeo_css 23:26:35 INFO - Generating results file: dromaeo_css 23:26:35 INFO - Working with test: kraken 23:26:35 INFO - Generating results file: kraken 23:26:35 INFO - javascript benchmark 23:26:35 INFO - Working with test: v8_7 23:26:35 INFO - Generating results file: v8_7 23:26:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:26:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:26:35 INFO - process_Request line: dromaeo_css 6884.48 graph.html#tests=[[72,64,43]] 23:26:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:26:35 INFO - process_Request line: kraken 1513.60 graph.html#tests=[[232,64,43]] 23:26:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:26:35 INFO - process_Request line: v8_7 20440.12 graph.html#tests=[[230,64,43]] 23:26:35 INFO - RETURN: dromaeo_css: 6884.48 23:26:35 INFO - RETURN: kraken: 1513.60 23:26:35 INFO - RETURN: v8_7: 20440.12 23:26:35 INFO - javascript benchmark 23:26:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3235.0780027692103, 3269.427850126229, 3278.6557411471804, 3279.147421670365, 3301.950470742939, 5253.9737301313535, 5256.1590145576665, 5264.131418315973, 5348.786048558058, 5349.411564727877, 5253.343332083489, 5358.089124848775, 5420.268263784388, 5441.700706461143, 5445.856370162271, 4597.241455159895, 4870.561649451549, 4984.975075124619, 4989.301497790312, 4995.950040499585, 4828.71027738335, 4902.7058376497525, 4905.288733133693, 4961.082199793032, 4982.9252561211615, 4845.0, 4892.584130348942, 4895.534924182232, 4940.604751619861, 4962.702237865739, 4889.364382630235, 4895.363602731658, 4911.4106307243, 4917.40991081069, 4938.876528086791, 4818.325434439182, 4889.196469024314, 4898.02039592083, 4924.285978533128, 4969.204927211629, 5028.069807085701, 5045.091883460976, 5074.5432911037815, 5085.694858308476, 5102.056119617845, 5776.249087618625, 5827.912581311284, 5833.7374818133285, 5834.4165583441745, 5835.679037652927, 5757.309122905278, 5793.246877905845, 5842.899971660538, 5874.706264686792, 5910.290765108214, 5408.378036525811, 5428.4842939920645, 5430.619856610078, 5436.238926550286, 5474.890502189934, 5823.068309070529, 5861.824145275648, 5862.12068189775, 5868.794592189338, 5895.292564892155, 5551.333839939233, 5634.85912852182, 5638.661680299195, 5706.771729130871, 5719.742611582489, 5767.423257674199, 5769.048107062372, 5786.826395208151, 5788.016037273674, 5821.505172060338, 5656.208130861683, 5674.971625141848, 5714.457126572969, 5740.54075673945, 5744.4829965303325, 5588.86027849307, 5682.914756278659, 5738.340090889517, 5781.0, 5912.231409916683, 4470.105978804252, 4494.280915053576, 4500.347449619787, 4504.842330518416, 4525.864224073283, 4004.1190937993597, 4013.337799263147, 4014.8996275093355, 4054.9391759123637, 4061.025353915039, 5324.7870085196155, 5368.570514358842, 5370.62405631602, 5394.433584473573, 5456.781728730806, 5750.396208398141, 5790.218320526759, 5796.21751063601, 5798.043322851767, 5800.361960184377, 5382.165764306539, 5438.211459338374, 5445.782168713286, 5447.073997420448, 5452.972735136299, 4815.422149342031, 4859.222524396079, 4885.0, 4946.233333833262, 4953.876153096201, 6039.728212230372, 6069.878602427927, 6095.664738439428, 6104.847378815565, 6117.204763380821, 5798.449147330997, 5810.273715785527, 5851.444112809277, 5861.882762344644, 5866.765329386777, 5929.881402372014, 5958.612690175125, 5962.07587823888, 5984.611000285142, 5988.610740301867, 5698.401667824819, 5764.9711751442655, 5783.103618939072, 5812.709364531672, 5855.092460668603, 5823.4467725566, 5831.533477321719, 5836.912446313394, 5839.124131380327, 5843.474087332161, 5623.353314368736, 5680.233168522362, 5682.261306030189, 5683.602147849776, 5691.2032315475035, 5581.804636837691, 5607.915881261866, 5650.180723795109, 5660.122680984454, 5663.093904975184, 5565.332160140809, 5609.88780224385, 5649.039663257338, 5655.066913959316, 5667.234923285304, 5638.605297629127, 5653.886922261449, 5740.856478588069, 5754.53963682896, 5777.9133313001175, 5684.857878553069, 5724.255846739898, 5731.742071606871, 5735.713214339183, 5739.856503587277], "unit": "score", "name": "dojo.html", "value": 5333.68432093529}, {"lowerIsBetter": false, "replicates": [529.3885562175686, 530.0776648631381, 530.7558523079383, 551.1539786427833, 556.0796881161679, 35887.28225435493, 35978.999999999935, 36097.458538121886, 36235.63764362359, 36308.455373169425, 39532.40701389474, 39960.60039399605, 39968.400473992915, 39971.0, 40244.79877600608, 8271.710490132846, 8458.619362128687, 8509.0, 8512.106228845974, 8542.487450752944, 8314.251717345467, 8474.067852536216, 8477.237048665618, 8492.617832197535, 8534.231919127278, 8705.085965973576, 8732.0, 8738.388312818106, 8749.693760718375, 8758.474491530496, 8585.356098292621, 8608.956955215215, 8622.008469026048, 8648.394612377137, 8714.0, 8483.0, 8588.656453741844, 8601.225889669897, 8623.09457506959, 8647.221750042463, 40716.0, 40754.184916301805, 40912.59087409118, 40951.7952410239, 40994.79502602498, 2867.3691787806647, 2982.9850850745606, 3010.804297720641, 3263.4778435450453, 3567.2009310084677, 28293.575596365867, 28498.907563443383, 28512.28719282014, 29038.12885613435, 29058.128256152348, 3735.3649879520276, 3736.645018723217, 3799.0, 3883.7087218458446, 3936.2810778621297, 262742.0, 271018.0, 271378.0, 273251.0, 273634.63182684156, 55490.16764748532, 55577.444225558036, 55722.0, 55967.0, 56415.71792141013, 67210.32789672041, 68906.310936891, 69158.0, 69319.65340173266, 69618.65190674014, 14637.780433293296, 14715.0, 14738.484153054806, 14839.480618178311, 14891.18098504571, 10605.0, 10632.30889992148, 10650.57397704083, 10688.251822372515, 10703.090237329914, 21177.15291388358, 21407.89296053541, 21631.242906498195, 21730.782692172877, 21865.12539498402, 8413.663453461915, 8435.451695639764, 8536.573171341532, 8693.521856297837, 8779.912200878038, 861.7716305179133, 934.1825902335456, 998.7153661206521, 1078.7518870659635, 1089.1444287223142, 27594.172174834788, 30502.847485762428, 30556.23609409738, 31205.063848084596, 32335.51496727551, 927.2767241551601, 970.8058388322364, 985.4136788610765, 993.6770549571419, 1020.2857999400301, 14688.485902993343, 14937.103773773608, 14938.850611493963, 14976.251187440585, 15160.241987900561, 371302.0, 374714.0, 375793.0, 375808.0, 377273.47722397954, 53666.46333536615, 54006.18990715143, 54031.18953215705, 54161.0, 54371.184432233546, 1245.5017992802952, 1250.7123361626877, 1253.793124134544, 1258.3205069262679, 1271.0848189303686, 24423.0, 25104.37239068965, 25256.242312730647, 25279.620805687562, 25390.873045634653, 45876.541234587225, 45889.311660324456, 46280.768596156806, 46322.0, 46502.53497464982, 297574.0, 300928.0, 302113.0, 302175.0, 305382.0, 33117.0, 44038.55961440473, 44112.33831492466, 44836.10327793361, 45060.32409513794, 39274.022340825846, 39283.0, 39557.2088558233, 39678.60321396749, 40148.799256003535, 35489.82255088708, 35533.82233088818, 36210.63789362178, 36701.26597468089, 36824.81587592045, 37357.62642373541, 37449.251014979, 37683.0, 38767.0, 39083.21833563256, 33465.33069338648, 33783.83108084444, 33913.83043084769, 33967.66032339645, 34006.82996585001, 30296.09111726652, 30762.230944226572, 32233.0, 32343.514847276838, 32453.837730811196, 24651.260462186165, 24664.260072197863, 24672.25983220506, 24984.500309994062, 25022.74977250277], "unit": "score", "name": "ext.html", "value": 18439.711579001505}, {"lowerIsBetter": false, "replicates": [366.730453116959, 369.92786406650697, 375.5493407910508, 377.38109500419307, 383.5340061824882, 14980.0, 16338.0, 16417.67164656706, 16947.49157525273, 17164.742528862047, 10304.639337623184, 10422.27044106911, 10534.473276336192, 10623.15014798816, 10646.893531064687, 4657.953420465786, 4662.300654901758, 4794.0, 4802.399700037496, 4850.126977144113, 4695.436547614291, 4715.622750179978, 4763.4998325175875, 4786.449558300787, 4789.712617242959, 3695.778253304797, 4775.737334446604, 4781.258904869734, 5191.402988656315, 5909.172715819789, 5338.412774594792, 5873.177755114288, 5907.232059832216, 5907.88184236315, 5931.792387266447, 5109.923351149736, 5161.561267292247, 5165.251038599419, 5174.586033117342, 5191.740412979374, 12310.199837010656, 15833.762493562606, 19354.903225483922, 20132.094055767524, 20177.8991105045, 1850.5373656585853, 1935.5644979879414, 2004.8997550122435, 2033.8779673219653, 2095.1619352259067, 8753.956230218871, 9066.456012639263, 9084.545772711404, 9171.633134674672, 9451.574679139456, 1766.5230387795223, 1804.1971322761376, 1859.3678149429124, 1859.944201673952, 1868.3740946782843, 55695.72152139214, 57255.42744572543, 57517.71241143768, 58453.0, 59013.7049314755, 9268.165865072042, 9845.950770246103, 10359.0, 10385.688429347132, 10411.271211015157, 13442.260675662932, 13452.5291614793, 13475.797863032063, 13527.932360338134, 13572.93213533926, 7404.296591823876, 7496.400287976949, 7530.096388433423, 7538.547687138789, 7574.204708505637, 7031.8945215821805, 7051.153861536648, 7148.070750802466, 7230.168530618941, 7244.130704315516, 4243.639290660267, 4318.805653745589, 4385.6710746694125, 4390.846320378771, 4435.977820110878, 1833.5782769962984, 1863.478226096668, 1890.9432717018512, 1914.9808501914802, 2816.7466027178584, 823.4770920465428, 866.77463859397, 898.0736320592423, 925.6945208081318, 983.852422136671, 14429.85570144306, 14886.255687215813, 15067.0, 15211.239438028055, 15472.458463953708, 795.3398679096337, 798.7523867601062, 875.1773333066897, 892.9821403571892, 951.2390087929629, 8529.445586036887, 8610.0, 8702.0, 9422.95288523553, 9686.951565242129, 550508.0, 562859.0, 564534.0, 570112.0, 592347.0, 71471.64264178646, 72362.0, 73272.63363683148, 74461.25538744651, 74889.0, 1095.4084794211037, 1111.5053801058452, 1112.710695219249, 1119.798436281461, 1127.5940661361903, 14305.21321327337, 14427.3507692152, 14802.62993425173, 15025.699486010437, 15140.167290799112, 31731.841340793148, 32910.17724556905, 32970.0, 33505.83247083847, 34044.829775850965, 37224.62775372212, 37432.06419839526, 37739.62260377361, 38089.0, 38908.221835563694, 7236.710531578678, 7349.559026458216, 7373.77878663641, 7473.065866766654, 7529.887051694339, 3549.272399158218, 4302.67729920251, 10032.0, 10399.480025998519, 11241.437928103725, 6740.696668650021, 8799.096298221699, 9119.817603647758, 9121.179093881317, 9221.123993220634, 9304.581293841658, 9433.905660943303, 9541.522923853641, 9691.418514889128, 10000.349977251455, 8860.468371897707, 9119.954400228222, 9122.635094596142, 9240.861387079065, 9285.07149285066, 7268.313792983398, 7272.672729727069, 7302.196758356683, 7327.487075904635, 7501.512401693873, 8398.370122240734, 8626.051134375339, 8716.346274029347, 8723.825523489622, 8802.25180859634], "unit": "score", "name": "jquery.html", "value": 7775.740535011241}, {"lowerIsBetter": false, "replicates": [1461.3570029187158, 1469.3681716861752, 1624.902505849649, 1752.0, 1773.4325015994887, 7631.771046868603, 7792.92207077929, 7856.489328193664, 7966.60166991651, 7992.760217193486, 7765.650545725442, 7826.413019023582, 7850.607469626524, 7912.327452166573, 7915.8416831663335, 2306.08909480755, 2360.905563777447, 2363.267387109993, 2367.550165468564, 2369.123424332999, 2343.6836027136374, 2364.7635236476385, 2368.4078980254935, 2370.4073981504625, 2373.596488596943, 2277.430642339415, 2295.5638428698576, 2298.885055747214, 2329.9534009319805, 2339.4736184358553, 2301.873396963166, 2331.195737470587, 2336.380859072339, 2348.342464110052, 2365.2785900300314, 2338.695969523968, 2343.133040774907, 2365.3613524348502, 2366.9053237870467, 2376.1445879483545, 7769.689212431496, 7835.138134805167, 7842.764717058498, 7854.842903141962, 7854.921450785476, 4821.783019764119, 4950.084234416644, 4973.0, 4976.950230497721, 5018.949810501885, 2955.468015757163, 3016.457037733207, 3066.9725641909986, 3077.3691393264326, 3082.0445661844674, 957.7892863570004, 972.4797233480125, 998.6005597760953, 1013.9746506337327, 1029.7425643589104, 10836.891631083747, 10949.4525273736, 10981.560737570408, 11001.119910407147, 11038.779224415546, 4313.223619748475, 4443.600075993176, 4476.753778542212, 4503.684742068024, 4518.186726389215, 9341.719748407559, 9404.717858464257, 9473.194778443909, 9519.048095190425, 9541.2367010639, 4909.7790599423115, 4936.506349365107, 4940.481249468826, 4942.654014218971, 4946.579540739005, 4381.518033016366, 4383.452068491439, 4395.318725597537, 4439.311906654474, 4466.3523789050405, 3541.3094446583186, 3616.3309787689363, 3619.221867298491, 3628.2924829657964, 3650.5619325681087, 1153.26191237608, 1177.7408970026581, 1198.2510930668332, 1200.2198570928965, 1201.765655697148, 1235.6972541727334, 1256.5916077274921, 1256.7486502699496, 1258.8111783232405, 1278.3352656618506, 7251.347378735939, 7262.455315851333, 7288.3076107769675, 7447.739329123455, 7466.141393739789, 1006.0773453118702, 1032.7160030991538, 1120.6301920366259, 1122.927009744364, 1124.4490199802037, 5357.8392648220615, 5451.945480545223, 5472.480114389126, 5559.082751346064, 5565.276514053228, 9125.36122471434, 9372.1565059145, 9441.055894410503, 9547.570359333846, 9794.0, 9142.725718228463, 9144.634214631473, 9191.218746406497, 9211.907880921239, 9304.069593040776, 7420.740274090381, 7459.664315105833, 7544.735934242385, 7559.924400755922, 7566.281203285679, 7525.90874323231, 7555.433342499225, 7619.657115429708, 7623.923760762322, 7639.847203056019, 8593.398462107592, 8638.352123590881, 8793.252573531321, 8924.598393072458, 9037.593308301011, 8715.869261960948, 8886.60010299551, 8900.287976961697, 8907.688230911886, 8943.060978597154, 7014.228434872058, 7054.929450705427, 7065.293470652894, 7090.0, 7124.786256412316, 7163.892541611985, 7166.032585601086, 7196.820079498055, 7224.0, 7257.983882256594, 6507.381798729113, 6730.629815360202, 6912.654367281716, 7183.102112235971, 7252.419806415369, 6744.494162937897, 6751.729930802713, 6914.377706006484, 6938.965305173442, 7138.500304978602, 6513.804585862432, 6518.869622607616, 6548.476121910331, 6579.671016449062, 6583.0454584086, 5945.494632956247, 6022.608530445507, 6068.241469816273, 6085.634861908123, 6096.390360963868, 5983.970080149571, 6008.609440386361, 6053.3946605339115, 6054.90917636227, 6089.147519347206], "unit": "score", "name": "mootools.html", "value": 4536.430204502867}, {"lowerIsBetter": false, "replicates": [347.16506801143254, 350.44804433017987, 353.00628730124697, 355.31601666791454, 358.11188253132246, 6172.4444799968, 6193.163922870411, 6215.347388524207, 6272.059191121329, 6399.648019358933, 6185.0, 6195.163652906856, 6200.1629779979685, 6233.1585235993125, 6254.124422580842, 4754.881127971794, 4805.399325084364, 4810.639202059842, 4816.277558366238, 4817.0847538967655, 4784.234522476405, 4809.615230781546, 4816.44610869751, 4822.059698358821, 4823.734694591796, 4686.27362758773, 4749.810007599692, 4779.545943135397, 4796.472388037313, 4799.880002999918, 4762.809487620491, 4768.403949506312, 4773.928391074137, 4779.020300838337, 4782.30656554801, 4137.0, 4145.357469592218, 4162.354835000579, 4167.708260421772, 4173.061061261223, 5925.762969481216, 5932.228810254639, 5938.673372964486, 5942.673152976585, 5955.583109182316, 5438.83683489496, 5550.47270509301, 5568.638038527482, 5571.832845014656, 5576.302962129734, 6633.734650613969, 6656.467482601381, 6669.333066693341, 6670.533062685614, 6678.398944095006, 4598.724076555417, 4606.516315786827, 4614.746188959606, 4618.630509559227, 4620.722756634613, 6681.732730690766, 6780.525363224576, 6879.3120687931305, 6902.206246281692, 6924.169099707967, 4649.0, 4657.580817726421, 4658.860234192912, 4659.114768194032, 4664.230401983635, 4712.2224832902875, 4715.174844402284, 4728.0543891221205, 4740.407449068866, 4745.193317136095, 5491.368492623399, 5501.339839219239, 5505.311836020497, 5510.8071217507995, 5540.750666220029, 6536.967315163393, 6626.834329141713, 6638.734450621921, 6641.1366522352755, 6642.070110184578, 1609.1069456451548, 1628.9185540722917, 1636.468147851929, 1637.263231545809, 1658.2537857963964, 1074.1299547366657, 1076.8761592416815, 1078.5577913055608, 1086.739182596187, 1095.1239008792934, 6145.324014358417, 6250.499960003189, 6296.275928268308, 6304.621722696653, 6306.590071645328, 6688.799336019927, 6727.596344219264, 6765.255821859591, 6778.93221067783, 6784.864302713918, 6124.540659450559, 6292.937070629327, 6307.211598550181, 6330.651814150266, 6368.235811702625, 3662.9450558241647, 3665.395209790355, 3672.2288319453214, 3682.5028621135802, 3697.4084146536425, 7079.0, 7086.468514861406, 7103.644817759091, 7105.89341159883, 7120.92879071213, 6735.696893639798, 6864.725410983605, 6885.173779146535, 6919.031335613018, 6928.930710692828, 7047.506674532836, 7070.540414873017, 7104.43164546835, 7125.964370178116, 7148.213696493382, 6733.653269346052, 6770.1537307836525, 6791.626460544718, 6820.9086546152375, 6908.792736217922, 6663.033860090357, 6810.114685090906, 6850.280720524273, 6868.313168683092, 6871.381575658214, 7142.142942846892, 7176.067111275501, 7180.594500842276, 7225.060742103493, 7225.674844631899, 4687.39063921688, 4737.360456338351, 4741.359916411378, 4744.691595046311, 4748.406449193851, 6700.966495167493, 6894.345357114356, 6915.688794004182, 6919.515633905779, 6937.202221744362, 6740.898886516804, 6762.932370676231, 6776.695048722918, 6795.422389096982, 6796.694148763218, 6728.932710673026, 6744.156980377453, 6776.491763117884, 6832.897506537505, 6845.452363810784, 6521.4130728232785, 6602.042703808017, 6612.867742645024, 6633.668316584248, 6676.6995485202315, 6747.696353664195, 6764.188297404146, 6795.456363491007, 6842.178938527409, 6860.279670634512, 6487.513436492188, 6623.006549017493, 6628.171478565179, 6635.0, 6644.235912869888], "unit": "score", "name": "prototype.html", "value": 5001.49610799705}, {"lowerIsBetter": false, "replicates": [734.8346622010047, 780.5745868501663, 792.3146478296276, 812.9227723366282, 834.0991728932752, 12739.0, 12757.744845103103, 12793.0, 12827.486900523967, 12910.0, 11477.483513241903, 11568.363739994318, 11574.53701851927, 11600.709982250426, 11601.3039217647, 768.7117331000875, 771.7877583664481, 775.1357236681088, 781.6443518199205, 803.7789607857827, 780.8672525670621, 782.7925599716051, 783.4515838912755, 784.3685832904509, 785.0736131365015, 829.0755807274875, 831.1231650608605, 831.2726364431123, 831.5468069901918, 836.188896770135, 826.396730386821, 826.921442462965, 827.4786884262905, 827.4828232354778, 831.3349320543541, 608.5101493297893, 608.9056196289582, 609.5489337889929, 611.9816405507842, 612.3142080869454, 12703.110782245247, 12731.172473789175, 12774.297413642245, 12810.80783788244, 12843.357832108451, 11997.880021199764, 12023.63929082129, 12237.877621223763, 12322.260664360077, 12366.938165309115, 10130.189584833195, 10186.28695991281, 10368.637097701545, 10369.585216591402, 10506.054455099002, 3491.5635545556806, 3579.0, 3619.819009049537, 3655.1775850433705, 3691.7969511676847, 48076.0, 48427.515724842655, 48634.51365486335, 49187.0, 49351.0, 9564.426134431957, 9684.806303873884, 9698.51507424626, 9725.124738773544, 9773.657921972697, 15537.689246215012, 15742.0, 15749.291281892343, 15888.126153061692, 17426.912865435846, 7039.436845052383, 7274.30894065063, 7343.816404589928, 7353.264673532604, 7442.106947166375, 4087.080406908422, 4199.853005144805, 4263.850765223202, 4266.360045993126, 4296.398504209413, 3216.630087539916, 3225.53229781685, 3233.951490727641, 3245.659205783406, 3246.6753324667816, 586.5805948746666, 594.337313895004, 604.4439116013278, 609.7103875659027, 622.8069298517474, 556.4852511426914, 646.208379799272, 646.9094326794252, 701.7824474412948, 707.1620130145691, 7885.580595492866, 8197.34421246299, 8539.74380768578, 8578.485290882441, 8634.481931084156, 569.7009070238158, 648.4488185042676, 666.8766278238444, 668.7425341243656, 736.1423941108656, 3744.5132132823105, 3897.8830635080994, 3971.940420893689, 3995.680345572347, 4079.7960101995377, 57467.42532574704, 57775.0, 58071.4192858066, 58423.70788146032, 58442.4155758437, 51206.48793512092, 51981.48018519842, 52260.738696306275, 52528.212076818876, 52655.21017184745, 46365.5363446368, 47457.52542474531, 47572.0, 47836.0, 47908.0, 7807.921920780719, 7901.328387086932, 7989.800254993672, 8042.276195142465, 8232.17678232172, 33473.330533389686, 33973.49039764455, 34287.65712342845, 35361.64638353584, 35538.64461355354, 40890.38664419977, 41333.58666413418, 45222.09555808931, 45449.0, 45556.31665524953, 9892.653757118467, 9901.950490247502, 9904.752381190528, 9949.900500995187, 9977.501124943868, 11504.367259800456, 11821.881781182077, 11971.10216733731, 12623.116381853182, 12699.047571432364, 10177.491125443847, 10298.691039268833, 10746.570137194425, 10971.561137554409, 11090.889091108986, 9897.406155630686, 10501.579936802442, 10578.735531611772, 10923.56305747793, 10962.287451315638, 9611.406289532913, 9946.0, 10770.623028193975, 11215.158863085138, 11357.943210283896, 9016.909830901606, 9047.68333108338, 9215.44707317563, 9280.489573073546, 9499.952500237454, 8580.14198580137, 8755.737327880173, 8823.823523529365, 8868.822623547621, 9451.621935122517], "unit": "score", "name": "yui.html", "value": 6135.558997375351}], "name": "dromaeo_css", "value": 6884.48082970808}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 110.0, 109.0, 122.0, 110.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [150.0, 135.0, 158.0, 165.0, 129.0, 146.0, 152.0, 137.0, 166.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 164.0, 162.0, 162.0, 162.0, 168.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 75.0, 74.0, 74.0, 153.0, 79.0, 73.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 147.0, 96.0, 98.0, 96.0, 139.0, 96.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 63.0, 78.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 62.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 73.0, 69.0, 75.0, 70.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 95.0, 85.0, 88.0, 87.0, 89.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [115.0, 120.0, 115.0, 118.0, 113.0, 121.0, 122.0, 123.0, 114.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 153.0, 156.0, 142.0, 130.0, 145.0, 141.0, 143.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 65.0, 68.0, 67.0, 67.0, 68.0, 66.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1513.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [189.465706707086], "unit": "score", "name": "DeltaBlue", "value": 348.97080399999993}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [688.2312456985547], "unit": "score", "name": "Earley", "value": 968.3707390000003}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [41420.0], "unit": "score", "name": "RegExp", "value": 21.993843553838726}, {"lowerIsBetter": false, "replicates": [585.480093676815], "unit": "score", "name": "Splay", "value": 139.18662800000004}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20440.115167873533}]} 23:26:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20440.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1513.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6884.48"}}} 23:26:35 INFO - Return code: 0 23:26:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:35 INFO - # TBPL SUCCESS # 23:26:35 INFO - Running post-action listener: _resource_record_post_action 23:26:35 INFO - Running post-run listener: _resource_record_post_run 23:26:37 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 550604800; Read time: 0; Write time: 428488 23:26:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236306432; Read time: 0; Write time: 249896 23:26:37 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 314298368; Read time: 0; Write time: 178592 23:26:37 INFO - Running post-run listener: _upload_blobber_files 23:26:37 INFO - Blob upload gear active. 23:26:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:26:37 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 23:26:37 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'] 23:26:37 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 23:26:37 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:38 INFO - (blobuploader) - INFO - Done attempting. 23:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:39 INFO - (blobuploader) - INFO - Done attempting. 23:26:39 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:39 INFO - Return code: 0 23:26:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:26:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a5388bd3fbcab5cc98f69446af5aebb2ec95fa5b096314a0d6ffa2daeee454c632759879e34027683ffbbbb5d781f4f13682a86922846f3963df0f501709b8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92a0820f4350dcd48b0fe836e2d80c72c99207b9c382dc4bd006d7fc87e661b7406b386a4134ac2ebb447085f479f6004012d00d4767324aa0da40462462cc11"} 23:26:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:26:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:26:39 INFO - Contents: 23:26:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a5388bd3fbcab5cc98f69446af5aebb2ec95fa5b096314a0d6ffa2daeee454c632759879e34027683ffbbbb5d781f4f13682a86922846f3963df0f501709b8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92a0820f4350dcd48b0fe836e2d80c72c99207b9c382dc4bd006d7fc87e661b7406b386a4134ac2ebb447085f479f6004012d00d4767324aa0da40462462cc11"} 23:26:39 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:39 INFO - Copying logs to upload dir... 23:26:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:26:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.764439 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-23 23:26:38.424266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 23:26:38.431671) ========= 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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 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/2a5388bd3fbcab5cc98f69446af5aebb2ec95fa5b096314a0d6ffa2daeee454c632759879e34027683ffbbbb5d781f4f13682a86922846f3963df0f501709b8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92a0820f4350dcd48b0fe836e2d80c72c99207b9c382dc4bd006d7fc87e661b7406b386a4134ac2ebb447085f479f6004012d00d4767324aa0da40462462cc11"} build_url:https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/Chz6PfLpQ1eoRqREoL7bcw/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/2a5388bd3fbcab5cc98f69446af5aebb2ec95fa5b096314a0d6ffa2daeee454c632759879e34027683ffbbbb5d781f4f13682a86922846f3963df0f501709b8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92a0820f4350dcd48b0fe836e2d80c72c99207b9c382dc4bd006d7fc87e661b7406b386a4134ac2ebb447085f479f6004012d00d4767324aa0da40462462cc11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 23:26:38.459717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:26:38.460077) ========= 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=6dbc10da6d83fee962c624be000001a8-1453616832.408508-589671306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 23:26:38.545303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 23:26:38.545661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 23:26:38.546012) ========= ========= Total master_lag: 0.36 =========