builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1453208301.94 results: success (0) buildid: 20160119023042 builduid: f62682b207fe4dafa557077ae2218d4c revision: 4824324ae86931bcbaecef47f8fb039bb7a42784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:21.945055) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:21.946059) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:21.946420) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006283 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:21.981664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:21.982010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.031216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.031672) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009536 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.094109) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.094495) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.094930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.095289) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 04:58:22-- 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% 81.6M=0s 2016-01-19 04:58:22 (81.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173949 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.297217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.297619) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.061861 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.376788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.377170) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4824324ae86931bcbaecef47f8fb039bb7a42784 --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 4824324ae86931bcbaecef47f8fb039bb7a42784 --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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 04:58:22,411 truncating revision to first 12 chars 2016-01-19 04:58:22,411 Setting DEBUG logging. 2016-01-19 04:58:22,411 attempt 1/10 2016-01-19 04:58:22,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4824324ae869?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 04:58:22,658 unpacking tar archive at: fx-team-4824324ae869/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559399 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.949595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:22.949980) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004634 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:23.002325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:23.002697) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:23.017355) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:23.017794) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 04:58:23.018365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-19 04:58:23.018732) ========= /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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:58:23 INFO - MultiFileLogger online at 20160119 04:58:23 in /builds/slave/test-pgo 04:58:23 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 04:58:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:58:23 INFO - {'append_to_log': False, 04:58:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:58:23 INFO - 'blob_upload_branch': 'Fx-Team', 04:58:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:58:23 INFO - 'branch': 'Fx-Team', 04:58:23 INFO - 'buildbot_json_path': 'buildprops.json', 04:58:23 INFO - 'config_files': ('talos/linux_config.py',), 04:58:23 INFO - 'default_actions': ('clobber', 04:58:23 INFO - 'read-buildbot-config', 04:58:23 INFO - 'download-and-extract', 04:58:23 INFO - 'populate-webroot', 04:58:23 INFO - 'create-virtualenv', 04:58:23 INFO - 'install', 04:58:23 INFO - 'run-tests'), 04:58:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:58:23 INFO - 'download_minidump_stackwalk': True, 04:58:23 INFO - 'download_symbols': 'ondemand', 04:58:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:58:23 INFO - 'tooltool.py': '/tools/tooltool.py', 04:58:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:58:23 INFO - '/tools/misc-python/virtualenv.py')}, 04:58:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:58:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:58:23 INFO - 'installer_path': 'installer.exe', 04:58:23 INFO - 'log_level': 'info', 04:58:23 INFO - 'log_name': 'talos', 04:58:23 INFO - 'log_to_console': True, 04:58:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:58:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:58:23 INFO - 'opt_config_files': (), 04:58:23 INFO - 'pip_index': False, 04:58:23 INFO - 'sps_profile': False, 04:58:23 INFO - 'sps_profile_interval': 0, 04:58:23 INFO - 'suite': 'dromaeojs-e10s', 04:58:23 INFO - 'system_bits': '32', 04:58:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:58:23 INFO - 'title': 'talos-linux64-ix-001', 04:58:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:58:23 INFO - 'use_talos_json': True, 04:58:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:58:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:58:23 INFO - 'work_dir': 'build'} 04:58:23 INFO - ##### 04:58:23 INFO - ##### Running clobber step. 04:58:23 INFO - ##### 04:58:23 INFO - Running pre-action listener: _resource_record_pre_action 04:58:23 INFO - Running main action method: clobber 04:58:23 INFO - rmtree: /builds/slave/test-pgo/build 04:58:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:58:27 INFO - Running post-action listener: _resource_record_post_action 04:58:27 INFO - ##### 04:58:27 INFO - ##### Running read-buildbot-config step. 04:58:27 INFO - ##### 04:58:27 INFO - Running pre-action listener: _resource_record_pre_action 04:58:27 INFO - Running main action method: read_buildbot_config 04:58:27 INFO - Using buildbot properties: 04:58:27 INFO - { 04:58:27 INFO - "project": "", 04:58:27 INFO - "product": "firefox", 04:58:27 INFO - "script_repo_revision": "production", 04:58:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:58:27 INFO - "repository": "", 04:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:58:27 INFO - "buildid": "20160119023042", 04:58:27 INFO - "pgo_build": "True", 04:58:27 INFO - "basedir": "/builds/slave/test-pgo", 04:58:27 INFO - "buildnumber": 452, 04:58:27 INFO - "slavename": "talos-linux64-ix-001", 04:58:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:58:27 INFO - "platform": "ubuntu64_hw", 04:58:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:58:27 INFO - "branch": "fx-team", 04:58:27 INFO - "repo_path": "integration/fx-team", 04:58:27 INFO - "revision": "4824324ae86931bcbaecef47f8fb039bb7a42784", 04:58:27 INFO - "stage_platform": "linux64-pgo", 04:58:27 INFO - "builduid": "f62682b207fe4dafa557077ae2218d4c", 04:58:27 INFO - "slavebuilddir": "test" 04:58:27 INFO - } 04:58:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:58:27 INFO - Running post-action listener: _resource_record_post_action 04:58:27 INFO - ##### 04:58:27 INFO - ##### Running download-and-extract step. 04:58:27 INFO - ##### 04:58:27 INFO - Running pre-action listener: _resource_record_pre_action 04:58:27 INFO - Running main action method: download_and_extract 04:58:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:27 INFO - https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/test_packages.json 04:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/test_packages.json 04:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:58:28 INFO - Downloaded 1448 bytes. 04:58:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:58:28 INFO - Using the following test package requirements: 04:58:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:58:28 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:58:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'jsshell-linux-x86_64.zip'], 04:58:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:58:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:58:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:58:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:58:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:58:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:28 INFO - https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:29 INFO - Downloaded 22484312 bytes. 04:58:29 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'] 04:58:29 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 04:58:30 INFO - Return code: 0 04:58:30 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 04:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:30 INFO - https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:32 INFO - Downloaded 22484312 bytes. 04:58:32 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'] 04:58:32 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 04:58:34 INFO - Return code: 0 04:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:34 INFO - https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:35 INFO - Downloaded 11132144 bytes. 04:58:35 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'] 04:58:35 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 04:58:35 INFO - Return code: 0 04:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:35 INFO - https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrNHram-Rx6-xh3lyzLGxg/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 04:58:37 INFO - Downloaded 55943528 bytes. 04:58:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:58:37 INFO - mkdir: /builds/slave/test-pgo/properties 04:58:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:58:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:58:37 INFO - Contents: 04:58:37 INFO - build_url:https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:58:37 INFO - Running post-action listener: _resource_record_post_action 04:58:37 INFO - Running post-action listener: set_extra_try_arguments 04:58:37 INFO - ##### 04:58:37 INFO - ##### Running populate-webroot step. 04:58:37 INFO - ##### 04:58:37 INFO - Running pre-action listener: _resource_record_pre_action 04:58:37 INFO - Running main action method: populate_webroot 04:58:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:37 INFO - '--tppagecycles', 04:58:37 INFO - '7'], 04:58:37 INFO - 'tests': ['tsvgm']}}, 04:58:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:58:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:58:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:58:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'tests': ['damp', 'tps']}, 04:58:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['damp', 'tps']}, 04:58:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:58:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:37 INFO - 'other': {'tests': ['a11yr', 04:58:37 INFO - 'ts_paint', 04:58:37 INFO - 'tpaint', 04:58:37 INFO - 'sessionrestore', 04:58:37 INFO - 'sessionrestore_no_auto_restore']}, 04:58:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['a11yr', 04:58:37 INFO - 'ts_paint', 04:58:37 INFO - 'tpaint', 04:58:37 INFO - 'sessionrestore', 04:58:37 INFO - 'sessionrestore_no_auto_restore']}, 04:58:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['a11yr', 04:58:37 INFO - 'ts_paint', 04:58:37 INFO - 'tpaint', 04:58:37 INFO - 'sessionrestore', 04:58:37 INFO - 'sessionrestore_no_auto_restore']}, 04:58:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['a11yr', 04:58:37 INFO - 'ts_paint', 04:58:37 INFO - 'tpaint', 04:58:37 INFO - 'sessionrestore', 04:58:37 INFO - 'sessionrestore_no_auto_restore']}, 04:58:37 INFO - 'other_l64': {'tests': ['a11yr', 04:58:37 INFO - 'ts_paint', 04:58:37 INFO - 'tpaint', 04:58:37 INFO - 'sessionrestore', 04:58:37 INFO - 'sessionrestore_no_auto_restore']}, 04:58:37 INFO - 'other_nol64': {'tests': ['a11yr', 04:58:37 INFO - 'ts_paint', 04:58:37 INFO - 'tpaint', 04:58:37 INFO - 'sessionrestore', 04:58:37 INFO - 'sessionrestore_no_auto_restore']}, 04:58:37 INFO - 'svgr': {'tests': ['tsvgx', 04:58:37 INFO - 'tsvgr_opacity', 04:58:37 INFO - 'tart', 04:58:37 INFO - 'tscrollx', 04:58:37 INFO - 'cart']}, 04:58:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['tsvgx', 04:58:37 INFO - 'tsvgr_opacity', 04:58:37 INFO - 'tart', 04:58:37 INFO - 'tscrollx', 04:58:37 INFO - 'cart']}, 04:58:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'tests': ['tp5o']}, 04:58:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'talos_options': ['--e10s'], 04:58:37 INFO - 'tests': ['tp5o']}, 04:58:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'talos_options': ['--xperf_path', 04:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:37 INFO - 'tests': ['tp5n']}, 04:58:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:37 INFO - 'talos_options': ['--e10s', 04:58:37 INFO - '--xperf_path', 04:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:37 INFO - 'tests': ['tp5n']}}, 04:58:37 INFO - 'talos.zip': {'path': '', 04:58:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:37 INFO - Running post-action listener: _resource_record_post_action 04:58:37 INFO - ##### 04:58:37 INFO - ##### Running create-virtualenv step. 04:58:37 INFO - ##### 04:58:37 INFO - Running pre-action listener: _resource_record_pre_action 04:58:37 INFO - Running main action method: create_virtualenv 04:58:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:58:37 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 04:58:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:58:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:37 INFO - Using real prefix '/usr' 04:58:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:58:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:40 INFO - Installing pip.................done. 04:58:40 INFO - Return code: 0 04:58:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:58: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')]} 04:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:58:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:58:40 INFO - Using env: {'DISPLAY': ':0', 04:58:40 INFO - 'HOME': '/home/cltbld', 04:58:40 INFO - 'LANG': 'en_US.UTF-8', 04:58:40 INFO - 'LANGUAGE': 'en_US:en', 04:58:40 INFO - 'LOGNAME': 'cltbld', 04:58:40 INFO - 'MAIL': '/var/mail/cltbld', 04:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:40 INFO - 'MOZ_NO_REMOTE': '1', 04:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:40 INFO - 'NO_EM_RESTART': '1', 04:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:40 INFO - 'SHELL': '/bin/bash', 04:58:40 INFO - 'SHLVL': '1', 04:58:40 INFO - 'TERM': 'linux', 04:58:40 INFO - 'TMOUT': '86400', 04:58:40 INFO - 'USER': 'cltbld', 04:58:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:40 INFO - '_': '/tools/buildbot/bin/python'} 04:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:40 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 04:58:40 INFO - Cleaning up... 04:58:40 INFO - Return code: 0 04:58:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:58: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')]} 04:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:58:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:58:40 INFO - Using env: {'DISPLAY': ':0', 04:58:40 INFO - 'HOME': '/home/cltbld', 04:58:40 INFO - 'LANG': 'en_US.UTF-8', 04:58:40 INFO - 'LANGUAGE': 'en_US:en', 04:58:40 INFO - 'LOGNAME': 'cltbld', 04:58:40 INFO - 'MAIL': '/var/mail/cltbld', 04:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:40 INFO - 'MOZ_NO_REMOTE': '1', 04:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:40 INFO - 'NO_EM_RESTART': '1', 04:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:40 INFO - 'SHELL': '/bin/bash', 04:58:40 INFO - 'SHLVL': '1', 04:58:40 INFO - 'TERM': 'linux', 04:58:40 INFO - 'TMOUT': '86400', 04:58:40 INFO - 'USER': 'cltbld', 04:58:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:40 INFO - '_': '/tools/buildbot/bin/python'} 04:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:40 INFO - Downloading/unpacking psutil>=0.7.1 04:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:42 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:58:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:42 INFO - Installing collected packages: psutil 04:58:42 INFO - Running setup.py install for psutil 04:58:42 INFO - building 'psutil._psutil_linux' extension 04:58:42 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 04:58:42 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 04:58:42 INFO - building 'psutil._psutil_posix' extension 04:58:42 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 04:58:42 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 04:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:42 INFO - Successfully installed psutil 04:58:42 INFO - Cleaning up... 04:58:42 INFO - Return code: 0 04:58:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:58:42 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')]} 04:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:42 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')]} 04:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:58:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:58:42 INFO - Using env: {'DISPLAY': ':0', 04:58:42 INFO - 'HOME': '/home/cltbld', 04:58:42 INFO - 'LANG': 'en_US.UTF-8', 04:58:42 INFO - 'LANGUAGE': 'en_US:en', 04:58:42 INFO - 'LOGNAME': 'cltbld', 04:58:42 INFO - 'MAIL': '/var/mail/cltbld', 04:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:42 INFO - 'MOZ_NO_REMOTE': '1', 04:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:42 INFO - 'NO_EM_RESTART': '1', 04:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:42 INFO - 'SHELL': '/bin/bash', 04:58:42 INFO - 'SHLVL': '1', 04:58:42 INFO - 'TERM': 'linux', 04:58:42 INFO - 'TMOUT': '86400', 04:58:42 INFO - 'USER': 'cltbld', 04:58:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:42 INFO - '_': '/tools/buildbot/bin/python'} 04:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:58:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:58:44 INFO - Installing collected packages: mozsystemmonitor 04:58:44 INFO - Running setup.py install for mozsystemmonitor 04:58:44 INFO - Successfully installed mozsystemmonitor 04:58:44 INFO - Cleaning up... 04:58:44 INFO - Return code: 0 04:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:58:44 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')]} 04:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:44 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')]} 04:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:58:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:58:44 INFO - Using env: {'DISPLAY': ':0', 04:58:44 INFO - 'HOME': '/home/cltbld', 04:58:44 INFO - 'LANG': 'en_US.UTF-8', 04:58:44 INFO - 'LANGUAGE': 'en_US:en', 04:58:44 INFO - 'LOGNAME': 'cltbld', 04:58:44 INFO - 'MAIL': '/var/mail/cltbld', 04:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:44 INFO - 'MOZ_NO_REMOTE': '1', 04:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:44 INFO - 'NO_EM_RESTART': '1', 04:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:44 INFO - 'SHELL': '/bin/bash', 04:58:44 INFO - 'SHLVL': '1', 04:58:44 INFO - 'TERM': 'linux', 04:58:44 INFO - 'TMOUT': '86400', 04:58:44 INFO - 'USER': 'cltbld', 04:58:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:44 INFO - '_': '/tools/buildbot/bin/python'} 04:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58:46 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 04:58:46 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 04:58:46 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 04:58:46 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 04:58:46 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 04:58:46 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 04:58:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:47 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 04:58:47 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 04:58:47 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 04:58:47 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 04:58:47 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 04:58:47 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 04:58:47 INFO - Downloading docopt-0.6.1.tar.gz 04:58:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:47 INFO - Running setup.py install for blobuploader 04:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:58:47 INFO - Running setup.py install for requests 04:58:48 INFO - Running setup.py install for docopt 04:58:48 INFO - Successfully installed blobuploader requests docopt 04:58:48 INFO - Cleaning up... 04:58:48 INFO - Return code: 0 04:58:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58: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')]} 04:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:58:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:48 INFO - Using env: {'DISPLAY': ':0', 04:58:48 INFO - 'HOME': '/home/cltbld', 04:58:48 INFO - 'LANG': 'en_US.UTF-8', 04:58:48 INFO - 'LANGUAGE': 'en_US:en', 04:58:48 INFO - 'LOGNAME': 'cltbld', 04:58:48 INFO - 'MAIL': '/var/mail/cltbld', 04:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:48 INFO - 'MOZ_NO_REMOTE': '1', 04:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:48 INFO - 'NO_EM_RESTART': '1', 04:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:48 INFO - 'SHELL': '/bin/bash', 04:58:48 INFO - 'SHLVL': '1', 04:58:48 INFO - 'TERM': 'linux', 04:58:48 INFO - 'TMOUT': '86400', 04:58:48 INFO - 'USER': 'cltbld', 04:58:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:48 INFO - '_': '/tools/buildbot/bin/python'} 04:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:48 INFO - Running setup.py (path:/tmp/pip-suW4lX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:48 INFO - Running setup.py (path:/tmp/pip-iLKAXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:48 INFO - Running setup.py (path:/tmp/pip-b_Kxi3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:48 INFO - Running setup.py (path:/tmp/pip-31fkND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:48 INFO - Running setup.py (path:/tmp/pip-oqIfbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:48 INFO - Running setup.py (path:/tmp/pip-9wJcR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:48 INFO - Running setup.py (path:/tmp/pip-IMpBsa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:48 INFO - Running setup.py (path:/tmp/pip-M6qRqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:48 INFO - Running setup.py (path:/tmp/pip-BnW9kE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:49 INFO - Running setup.py (path:/tmp/pip-in1zWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:49 INFO - Running setup.py (path:/tmp/pip-MTOWuF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:49 INFO - Running setup.py (path:/tmp/pip-LAqBlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:49 INFO - Running setup.py (path:/tmp/pip-ZvQl0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:49 INFO - Running setup.py (path:/tmp/pip-Bn9OQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:49 INFO - Running setup.py (path:/tmp/pip-DolyaE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:49 INFO - Running setup.py (path:/tmp/pip-l417v0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:49 INFO - Running setup.py (path:/tmp/pip-zLt2o9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:49 INFO - Running setup.py install for manifestparser 04:58:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:58:49 INFO - Running setup.py install for mozcrash 04:58:49 INFO - Running setup.py install for mozdebug 04:58:49 INFO - Running setup.py install for mozdevice 04:58:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Running setup.py install for mozfile 04:58:50 INFO - Running setup.py install for mozhttpd 04:58:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Running setup.py install for mozinfo 04:58:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Running setup.py install for mozInstall 04:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Running setup.py install for mozleak 04:58:50 INFO - Running setup.py install for mozlog 04:58:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Running setup.py install for moznetwork 04:58:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Running setup.py install for mozprocess 04:58:50 INFO - Running setup.py install for mozprofile 04:58:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:58:50 INFO - Running setup.py install for mozrunner 04:58:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:58:51 INFO - Running setup.py install for mozscreenshot 04:58:51 INFO - Running setup.py install for moztest 04:58:51 INFO - Running setup.py install for mozversion 04:58:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:51 INFO - Cleaning up... 04:58:51 INFO - Return code: 0 04:58:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:58:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:51 INFO - Using env: {'DISPLAY': ':0', 04:58:51 INFO - 'HOME': '/home/cltbld', 04:58:51 INFO - 'LANG': 'en_US.UTF-8', 04:58:51 INFO - 'LANGUAGE': 'en_US:en', 04:58:51 INFO - 'LOGNAME': 'cltbld', 04:58:51 INFO - 'MAIL': '/var/mail/cltbld', 04:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:51 INFO - 'MOZ_NO_REMOTE': '1', 04:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:51 INFO - 'NO_EM_RESTART': '1', 04:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:51 INFO - 'SHELL': '/bin/bash', 04:58:51 INFO - 'SHLVL': '1', 04:58:51 INFO - 'TERM': 'linux', 04:58:51 INFO - 'TMOUT': '86400', 04:58:51 INFO - 'USER': 'cltbld', 04:58:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:51 INFO - '_': '/tools/buildbot/bin/python'} 04:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:51 INFO - Running setup.py (path:/tmp/pip-MBvcuT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:51 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)) 04:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:51 INFO - Running setup.py (path:/tmp/pip-GRgRjp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:51 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)) 04:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:51 INFO - Running setup.py (path:/tmp/pip-F8hzp7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:51 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)) 04:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:51 INFO - Running setup.py (path:/tmp/pip-sgN8Hb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:51 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)) 04:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:51 INFO - Running setup.py (path:/tmp/pip-ZRNVPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:51 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)) 04:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:51 INFO - Running setup.py (path:/tmp/pip-iUiDYy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:52 INFO - Running setup.py (path:/tmp/pip-g2z9Ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:52 INFO - Running setup.py (path:/tmp/pip-07AYSp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:52 INFO - Running setup.py (path:/tmp/pip-Jm4yfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:52 INFO - Running setup.py (path:/tmp/pip-EwyP4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:52 INFO - Running setup.py (path:/tmp/pip-9skqYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:52 INFO - Running setup.py (path:/tmp/pip-1eiX3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:52 INFO - Running setup.py (path:/tmp/pip-6C2ORs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:52 INFO - Running setup.py (path:/tmp/pip-qbxtYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:52 INFO - Running setup.py (path:/tmp/pip-S5U3Yz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:52 INFO - Running setup.py (path:/tmp/pip-eIEszF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:52 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)) 04:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:52 INFO - Running setup.py (path:/tmp/pip-OczoM9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:52 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)) 04:58:52 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)) 04:58:52 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)) 04:58:52 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)) 04:58:52 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)) 04:58:52 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)) 04:58:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58:54 INFO - Downloading blessings-1.5.1.tar.gz 04:58:54 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:58:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:54 INFO - Installing collected packages: blessings 04:58:54 INFO - Running setup.py install for blessings 04:58:54 INFO - Successfully installed blessings 04:58:54 INFO - Cleaning up... 04:58:54 INFO - Return code: 0 04:58:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:58:54 INFO - Reading from file tmpfile_stdout 04:58:54 INFO - Current package versions: 04:58:54 INFO - argparse == 1.2.1 04:58:54 INFO - blessings == 1.5.1 04:58:54 INFO - blobuploader == 1.2.4 04:58:54 INFO - docopt == 0.6.1 04:58:54 INFO - manifestparser == 1.1 04:58:54 INFO - mozInstall == 1.12 04:58:54 INFO - mozcrash == 0.16 04:58:54 INFO - mozdebug == 0.1 04:58:54 INFO - mozdevice == 0.48 04:58:54 INFO - mozfile == 1.2 04:58:54 INFO - mozhttpd == 0.7 04:58:54 INFO - mozinfo == 0.9 04:58:54 INFO - mozleak == 0.1 04:58:54 INFO - mozlog == 3.1 04:58:54 INFO - moznetwork == 0.27 04:58:54 INFO - mozprocess == 0.22 04:58:54 INFO - mozprofile == 0.28 04:58:54 INFO - mozrunner == 6.11 04:58:54 INFO - mozscreenshot == 0.1 04:58:54 INFO - mozsystemmonitor == 0.0 04:58:54 INFO - moztest == 0.7 04:58:54 INFO - mozversion == 1.4 04:58:54 INFO - psutil == 3.1.1 04:58:54 INFO - requests == 1.2.3 04:58:54 INFO - wsgiref == 0.1.2 04:58:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:54 INFO - Using env: {'DISPLAY': ':0', 04:58:54 INFO - 'HOME': '/home/cltbld', 04:58:54 INFO - 'LANG': 'en_US.UTF-8', 04:58:54 INFO - 'LANGUAGE': 'en_US:en', 04:58:54 INFO - 'LOGNAME': 'cltbld', 04:58:54 INFO - 'MAIL': '/var/mail/cltbld', 04:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:54 INFO - 'MOZ_NO_REMOTE': '1', 04:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:54 INFO - 'NO_EM_RESTART': '1', 04:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:54 INFO - 'SHELL': '/bin/bash', 04:58:54 INFO - 'SHLVL': '1', 04:58:54 INFO - 'TERM': 'linux', 04:58:54 INFO - 'TMOUT': '86400', 04:58:54 INFO - 'USER': 'cltbld', 04:58:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:54 INFO - '_': '/tools/buildbot/bin/python'} 04:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 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)) 04:58:55 INFO - Cleaning up... 04:58:55 INFO - Return code: 0 04:58:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:58:55 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')]} 04:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:55 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')]} 04:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:58:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:58:55 INFO - Using env: {'DISPLAY': ':0', 04:58:55 INFO - 'HOME': '/home/cltbld', 04:58:55 INFO - 'LANG': 'en_US.UTF-8', 04:58:55 INFO - 'LANGUAGE': 'en_US:en', 04:58:55 INFO - 'LOGNAME': 'cltbld', 04:58:55 INFO - 'MAIL': '/var/mail/cltbld', 04:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:55 INFO - 'MOZ_NO_REMOTE': '1', 04:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:55 INFO - 'NO_EM_RESTART': '1', 04:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:55 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:55 INFO - 'SHELL': '/bin/bash', 04:58:55 INFO - 'SHLVL': '1', 04:58:55 INFO - 'TERM': 'linux', 04:58:55 INFO - 'TMOUT': '86400', 04:58:55 INFO - 'USER': 'cltbld', 04:58:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:55 INFO - '_': '/tools/buildbot/bin/python'} 04:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:55 INFO - Downloading/unpacking jsonschema 04:58:55 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 04:58:55 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 04:58:55 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 04:58:55 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 04:58:55 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 04:58:55 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 04:58:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:58:57 INFO - Downloading/unpacking functools32 (from jsonschema) 04:58:57 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 04:58:57 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 04:58:57 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 04:58:57 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 04:58:57 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 04:58:57 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 04:58:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:57 INFO - warning: no files found matching '*.txt' 04:58:57 INFO - no previously-included directories found matching 'build' 04:58:57 INFO - no previously-included directories found matching 'dist' 04:58:57 INFO - no previously-included directories found matching '.git*' 04:58:57 INFO - Installing collected packages: jsonschema, functools32 04:58:57 INFO - Running setup.py install for functools32 04:58:57 INFO - warning: no files found matching '*.txt' 04:58:57 INFO - no previously-included directories found matching 'build' 04:58:57 INFO - no previously-included directories found matching 'dist' 04:58:57 INFO - no previously-included directories found matching '.git*' 04:58:57 INFO - Successfully installed jsonschema functools32 04:58:57 INFO - Cleaning up... 04:58:57 INFO - Return code: 0 04:58:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:58: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')]} 04:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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')]} 04:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe500456f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', '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 04:58:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:58:57 INFO - Using env: {'DISPLAY': ':0', 04:58:57 INFO - 'HOME': '/home/cltbld', 04:58:57 INFO - 'LANG': 'en_US.UTF-8', 04:58:57 INFO - 'LANGUAGE': 'en_US:en', 04:58:57 INFO - 'LOGNAME': 'cltbld', 04:58:57 INFO - 'MAIL': '/var/mail/cltbld', 04:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:57 INFO - 'MOZ_NO_REMOTE': '1', 04:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:57 INFO - 'NO_EM_RESTART': '1', 04:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:57 INFO - 'SHELL': '/bin/bash', 04:58:57 INFO - 'SHLVL': '1', 04:58:57 INFO - 'TERM': 'linux', 04:58:57 INFO - 'TMOUT': '86400', 04:58:57 INFO - 'USER': 'cltbld', 04:58:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:57 INFO - '_': '/tools/buildbot/bin/python'} 04:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:57 INFO - Downloading/unpacking flake8 04:58:57 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 04:58:57 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 04:58:57 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 04:58:57 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 04:58:57 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 04:58:57 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 04:58:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:58:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:58:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:59:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:59:00 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 04:59:00 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 04:59:00 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 04:59:00 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 04:59:00 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 04:59:00 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 04:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:00 INFO - no previously-included directories found matching 'docs/_build' 04:59:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:59:00 INFO - Running setup.py install for pep8 04:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:59:00 INFO - no previously-included directories found matching 'docs/_build' 04:59:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:59:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:59:00 INFO - Cleaning up... 04:59:00 INFO - Return code: 0 04:59:00 INFO - Running post-action listener: _resource_record_post_action 04:59:00 INFO - Running post-action listener: _start_resource_monitoring 04:59:00 INFO - Starting resource monitoring. 04:59:00 INFO - ##### 04:59:00 INFO - ##### Running install step. 04:59:00 INFO - ##### 04:59:00 INFO - Running pre-action listener: _resource_record_pre_action 04:59:00 INFO - Running main action method: install 04:59:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:59:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:59:00 INFO - Reading from file tmpfile_stdout 04:59:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:59:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:59:00 INFO - Reading from file tmpfile_stdout 04:59:00 INFO - Output received: 04:59:00 INFO - Usage: mozinstall [options] installer 04:59:00 INFO - Options: 04:59:00 INFO - -h, --help show this help message and exit 04:59:00 INFO - -d DEST, --destination=DEST 04:59:00 INFO - Directory to install application into. [default: 04:59:00 INFO - "/builds/slave/test-pgo"] 04:59:00 INFO - --app=APP Application being installed. [default: firefox] 04:59:00 INFO - mkdir: /builds/slave/test-pgo/build/application 04:59:00 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'] 04:59:00 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 04:59:16 INFO - Reading from file tmpfile_stdout 04:59:16 INFO - Output received: 04:59:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:59:16 INFO - Running post-action listener: _resource_record_post_action 04:59:16 INFO - ##### 04:59:16 INFO - ##### Running run-tests step. 04:59:16 INFO - ##### 04:59:16 INFO - Running pre-action listener: _resource_record_pre_action 04:59:16 INFO - Running main action method: run_tests 04:59:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:59:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:59:16 INFO - Python 2.7.3 04:59:16 INFO - Return code: 0 04:59:16 INFO - grabbing minidump binary from tooltool 04:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:16 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 0x1d8a840>, '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 0x1cf76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:59:16 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 04:59:16 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 04:59:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:16 INFO - Return code: 0 04:59:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:59:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:59:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:59:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:59:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:59:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:59:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:59:17 INFO - Return code: 0 04:59:17 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/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:59:17 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/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 04:59:17 INFO - Using env: {'DISPLAY': ':0', 04:59:17 INFO - 'HOME': '/home/cltbld', 04:59:17 INFO - 'LANG': 'en_US.UTF-8', 04:59:17 INFO - 'LANGUAGE': 'en_US:en', 04:59:17 INFO - 'LOGNAME': 'cltbld', 04:59:17 INFO - 'MAIL': '/var/mail/cltbld', 04:59:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:59:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:17 INFO - 'MOZ_NO_REMOTE': '1', 04:59:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:17 INFO - 'NO_EM_RESTART': '1', 04:59:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:59:17 INFO - 'PWD': '/builds/slave/test-pgo', 04:59:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:59:17 INFO - 'SHELL': '/bin/bash', 04:59:17 INFO - 'SHLVL': '1', 04:59:17 INFO - 'TERM': 'linux', 04:59:17 INFO - 'TMOUT': '86400', 04:59:17 INFO - 'USER': 'cltbld', 04:59:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420', 04:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:17 INFO - '_': '/tools/buildbot/bin/python'} 04:59:17 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/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:59:18 INFO - mozversion application_buildid: 20160119023042 04:59:18 INFO - mozversion application_changeset: 4824324ae86931bcbaecef47f8fb039bb7a42784 04:59:18 INFO - mozversion application_display_name: Nightly 04:59:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:18 INFO - mozversion application_name: Firefox 04:59:18 INFO - mozversion application_remotingname: firefox 04:59:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:59:18 INFO - mozversion application_vendor: Mozilla 04:59:18 INFO - mozversion application_version: 46.0a1 04:59:18 INFO - mozversion platform_buildid: 20160119023042 04:59:18 INFO - mozversion platform_changeset: 4824324ae86931bcbaecef47f8fb039bb7a42784 04:59:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:59:18 INFO - mozversion platform_version: 46.0a1 04:59:18 INFO - using testdate: 1453208358 04:59:18 INFO - actual date: 1453208358 04:59:18 INFO - starting webserver on 'localhost:47527' 04:59:18 INFO - SUITE-START | Running 3 tests 04:59:18 INFO - TEST-START | dromaeo_css 04:59:18 INFO - operating with platform_type : linux_ 04:59:18 INFO - Initialising browser for dromaeo_css test... 04:59:18 INFO - TEST-INFO | started process 15606 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKixTmI/profile http://localhost:47527/getInfo.html) 04:59:21 INFO - PROCESS | 15606 | 04:59:21 INFO - PROCESS | 15606 | (process:15687): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:59:22 INFO - PROCESS | 15606 | __metrics Screen width/height:1600/1200 04:59:22 INFO - PROCESS | 15606 | colorDepth:24 04:59:22 INFO - PROCESS | 15606 | Browser inner width/height: 1024/697 04:59:22 INFO - PROCESS | 15606 | __metrics 04:59:22 INFO - PROCESS | 15606 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:59:23 INFO - TEST-INFO | 15606: exit 0 04:59:23 INFO - Browser initialized. 04:59:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:59:23 INFO - TEST-INFO | started process 15735 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKixTmI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:24 INFO - PROCESS | 15735 | -- checkerboarding starts below -- 04:59:24 INFO - PROCESS | 15735 | RENDERTRACE 0.04671 rect red 0 0 10 10 // viewport 04:59:24 INFO - PROCESS | 15735 | RENDERTRACE 10.5417 rect red 0 0 10 10 // viewport 04:59:24 INFO - PROCESS | 15735 | RENDERTRACE 60.1848 rect brown 0 0 10 10 // page 04:59:24 INFO - PROCESS | 15735 | RENDERTRACE 60.2091 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:59:24 INFO - PROCESS | 15735 | Checkerboarded for 2 frames (60.8625 ms), 100 peak, 1053 severity. 04:59:24 INFO - PROCESS | 15735 | 04:59:24 INFO - PROCESS | 15735 | (process:15795): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:59:35 INFO - PROCESS | 15735 | RSS: Main: 150323200 04:59:35 INFO - PROCESS | 15735 | 05:00:25 INFO - PROCESS | 15735 | 1453208425096 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] 05:02:34 INFO - PROCESS | 15735 | Cycle 1(1): loaded http://localhost:47527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47527/tests/dromaeo/cssquery-ext.html) 05:02:35 INFO - PROCESS | 15735 | RSS: Main: 156262400 05:02:35 INFO - PROCESS | 15735 | 05:05:37 INFO - PROCESS | 15735 | Cycle 1(1): loaded http://localhost:47527/tests/dromaeo/cssquery-ext.html (next: http://localhost:47527/tests/dromaeo/cssquery-jquery.html) 05:05:38 INFO - PROCESS | 15735 | RSS: Main: 153694208 05:05:38 INFO - PROCESS | 15735 | 05:08:39 INFO - PROCESS | 15735 | Cycle 1(1): loaded http://localhost:47527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47527/tests/dromaeo/cssquery-mootools.html) 05:08:40 INFO - PROCESS | 15735 | RSS: Main: 151478272 05:08:40 INFO - PROCESS | 15735 | 05:11:42 INFO - PROCESS | 15735 | Cycle 1(1): loaded http://localhost:47527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47527/tests/dromaeo/cssquery-prototype.html) 05:11:42 INFO - PROCESS | 15735 | RSS: Main: 150491136 05:11:42 INFO - PROCESS | 15735 | 05:14:45 INFO - PROCESS | 15735 | Cycle 1(1): loaded http://localhost:47527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47527/tests/dromaeo/cssquery-yui.html) 05:14:45 INFO - PROCESS | 15735 | RSS: Main: 151089152 05:14:45 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | Cycle 1(1): loaded http://localhost:47527/tests/dromaeo/cssquery-yui.html (next: http://localhost:47527/tests/dromaeo/cssquery-dojo.html) 05:17:48 INFO - PROCESS | 15735 | RSS: Main: 153096192 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | __start_tp_report 05:17:48 INFO - PROCESS | 15735 | _x_x_mozilla_page_load 05:17:48 INFO - PROCESS | 15735 | _x_x_mozilla_page_load_details 05:17:48 INFO - PROCESS | 15735 | |i|pagename|runs| 05:17:48 INFO - PROCESS | 15735 | |0;dojo.html;3247.415465216261;3255.430299697554;3295.555100061491;3303.2072302647366;3312.3872083664523;5243.711595862235;5301.780590464191;5377.085895397782;5383.703896285708;5385.703786291757;5303.337082864642;5312.096943519601;5364.490373414529;5429.4027656957805;5439.646422982503;4935.555799978001;4966.056449274644;5017.9247311290355;5033.295338652591;5045.117104506715;4911.066897289504;4980.252962055684;4984.277279794428;4989.725565093919;5011.799528018875;4833.927491087637;4874.366332376786;4917.40991081069;4918.90162196754;4925.950740492603;4846.321514987904;4854.101991131652;4882.389701287339;4928.654994150411;4961.404631444249;4874.073925954058;4916.680415772999;4917.459079501288;4920.532549407836;4921.286413470062;5229.640293523711;5257.211418287249;5270.420253772082;5284.81503147388;5304.814331498417;5710.2862142232225;5801.564882633819;5877.294724633029;5886.705664716747;5929.199558059693;5752.424757524256;5754.539636829044;5761.395053519362;5780.277465316835;5781.942180578182;5335.866603334947;5358.544523715489;5364.383095943938;5386.5152136307925;5386.622936394415;5799.5650326225705;6045.576809623284;6069;6088.360722124202;6128.3258841527395;5634.126710359901;5652.802151924663;5657.2079908811975;5665.008623490872;5671.319441667027;5656.85857853557;5693.68684722336;5744.770209191585;5753.741081651336;5757.222774925332;5628.774849005994;5755.9424405756245;5766.423357664284;5821.301443826768;5838.883222335529;5810.360860305363;5850.180974663551;5861.443162899518;5867.706614669335;5875.001249787546;4436.866893993185;4478.171538265431;4496.280595104768;4502.977485112619;4535.705179163344;3995.1210733638554;3997.960020399759;4024.899377515527;4026.832218656615;4067.1662309226535;5416;5485.451454854483;5495.945040549624;5516.255305533782;5528.44715528444;5654.575906807006;5752.856178595569;5846.824595262149;5884.823455296348;5902.291724993029;5328.786848526093;5338.039152952506;5375.569954403638;5376.677399356051;5428.022955867903;4873.731944743002;4881.438634557;4882.584980276716;4903.04390643821;4920.3603531541385;5842.8539286517325;5923.49650279731;6004.5496587755215;6013.098035294741;6062.484688801413;5825.94174058271;5826.592138550261;5829.8251052468495;5847.5906686533235;5881.2942446906645;5980.282366116094;6009.068594367705;6013.308469525886;6025.8192254232445;6050.757969681164;5679.119736440858;5680.801171958961;5704.372519022987;5787.94212057874;5792.768289268382;5732.484076433141;5752.539796816328;5764.394738552392;5775.162601422686;5806.129080637938;5602.215689803349;5609.49514543693;5611.859703507445;5615.691136987341;5645.971770141287;5549.38956714753;5619.80330688424;5629.605927585029;5650.604457688087;5720.599558030898;5423.186522021729;5445.373782014961;5467.234587157722;5471.06991811401;5476.205950137128;5515.917261241165;5562.638428502134;5568.777248909998;5577.163425486209;5620.269364982526;5437.782488700408;5500.367457742411;5553.555715542828;5561.499465048165;5564.582656300713 05:17:48 INFO - PROCESS | 15735 | |1;ext.html;516.9819056333029;546.461735190837;555.7721334252957;559.5747232103603;580.213810287061;34923.12692182694;35773.46339804898;35971.64028359719;36030;36109.27781444376;39393.40909886354;39957.20085598286;40089.59910400895;40251.798741006256;40519.59480405195;8472.406931514797;8586.398952073358;8619.655213791471;8658.523781192032;8663.913360866405;8391.916080839204;8475.237228649421;8500.404971651988;8619.698310559132;8633.69782057628;8652.48085114892;8726.214640682338;8762.386632935666;8795.736127916141;8809.515476648781;8674.913250867474;8742.475451472932;8755.562221888911;8764.079771623952;8766.517841518715;8648;8703;8765.693200738007;8770.122987701243;8787.0334263231;40259.19481610381;40630.593694063275;40707.592924070676;40760.38859417111;40829.795851020855;2679.3301674581353;3166.3034132490816;3206.64726880043;3501;4024.5975402459812;26571;27490.587641185397;28803.711962880312;29348.266293342625;29549.852250738822;3895.162540053902;3971.6028397160344;4020.959790402117;4048.6761059115493;4173.3114036184;228863;231853.84073079695;231901;232307;233806;55801;56356;56679;56762;56835.43164568301;64910.35089649138;66254.66872665702;66737;67009.32990670031;67033;14149.29253537319;14289.857101429061;14316.57050288493;14337.498187563593;14457.132572045712;10014.098731114234;10056.597736090474;10077.899221007843;10097.182507148636;10117.140043096419;20489.692654610193;20875.79124208769;20883.895580522305;20893.164273429196;20933.16267349289;8109.148539403395;8213.671453141927;8222.465539739898;8244.340452763765;8342.666293348198;938.6949241496404;956.5552018311519;1021.8211812932707;1044.9320794148357;1047.3872784421046;26296.47407051848;26366.86816565905;26381.076662316726;26440.338991524983;26475.602865957026;964.3683387381277;1111.8499002634542;1128.4752590045669;1135.693362792058;1139.880312567185;13848.584542463743;13893.374798133906;14153;14181.574552763434;14264.786028209584;415628;417661;418065;423123;424290;55229.723851380484;55270.06554770644;55643.44356556464;56060.43939560552;56181.43818561844;1312.6193403912757;1315.9144655597356;1335.9265240411871;1336.692560711042;1338.43785610044;26992;28097.297567560974;28320.43359132847;29504.557431638113;30499.616441068203;51141.74429127831;51829;51923.48076519187;52006.73996630144;52093.47906520886;317466;318224;319568;321562;322821;42974;43661;43686.781566091966;43691.78154109209;44526.77736611296;39161.2167756649;40423.59576404198;40440;40610.39084413677;41326;27394;27420.17739467819;27467.175984720492;27592.310192244553;30153.246168845955;38604.613953861226;39562;40226.39660405038;40324.79837600793;40922.38616420697;33866.322673546885;33991.320173595894;34275.65724342824;34428.13929651779;34613.13467163341;29526.114216573536;30282.242943925696;35003;36546.869948018364;36804.26391472102;24987;25422.74577254204;25438.745612543637;25523;25691.229263122135 05:17:48 INFO - PROCESS | 15735 | |2;jquery.html;369.36469272850695;370.2613286493444;370.73492452896176;371.9795411252381;375.363758429462;13704.52034178804;14952.775708364383;15706.607334816636;17224.3110275589;18152.909235453837;15500.689986200268;15793.368265269404;16227.432039878606;16232.83767162328;16391.18044097796;5147.330846989896;5520.696361700105;5523.420040895709;5526.806561770339;5531;5314.867128321785;5391.29913111295;5494.203340515623;5495.560355171597;5560.7219639018085;5489.533389661883;5499.697516636584;5518.613697041209;5539.446055394468;5543.77824887004;5313.229581710669;5424.294841670558;5459.071957767189;5490.862728431801;5503.7798488060425;4785.258284965836;4871.658983871131;4904.94543673112;4909.705417674951;4923.950760492421;19943.90028049865;20218;20518;20663.690044649342;20677.4830629234;2090.560982193741;2103.0956688623887;2154.91380344786;2212.9446763830874;2268.1040988809327;12601.243925364508;12736.36318184087;12789.168704034208;12913.549665593262;13036.86963130366;1797.1912639312231;1818.1545581304624;1825.4432398118568;1877.11775465531;1917.990410047941;53077.2038419424;53844.73077634626;53964.19053714197;57010.71494642542;57021.14468282979;9751.122398984126;9912.752181195383;9949.950250248847;10011.899881001096;10085.142762865238;12791.296478693575;13160.276184809927;13219.735605288033;13226;13271.402786874614;6632.436242919406;6653.9667301663185;6717.261101278856;6736.191657001191;6852.211995620568;6117.938820611737;6141.232345956755;6264.843378915563;6271.341509141565;6513.2184137902805;4435.645148388121;4450.933236001462;4498.2577874650315;4500.212462819059;4524.298733696282;1855.1466325490155;1919.2418994497095;1931.7681878174708;1941.6505029094617;1951.4243298227057;806.8023334283138;903.381183889025;907.0022974727747;1058.714147180257;1074.6346242277507;15386.9230653846;15791.684166316609;16299.59251018734;16411.42560010394;16507;908.504864848659;933.6918816790443;950.4392408479031;956.7608097975506;996.352370958868;8832.116788321116;8926.419782714103;8947.997638736646;9028.232600228923;9034.186923176945;396124;405037;570276;572887;579589;60088.098678519855;64011.35988640147;64565.44220134073;65610.34389656043;67750.32249677539;1100.4937728644752;1129.3788416370962;1144.5193018932234;1151.1021403305435;1154.440096553171;15117.395304188149;15145.469908553148;15185.392584296504;15310.31103600363;15757.13335766498;29864.25339366533;32043.67956320407;32203.677963221005;33543.49684754682;34149;35271.82364088163;35484.82257588695;35637;36886;37327.44008839815;7111.964440177766;7220.277972202738;7504.1370242420635;7591.62041897914;7781.610919453891;9982.900170998197;10870.510827012646;10982.945085274523;11222.214444989098;11262.436878155895;9147.908520914705;9161.331434886792;9460.101290377403;9561.330706850731;9895.604175832887;9493.85759213626;9711.174550163316;9762;10042.096211341015;10130;9218.723438296862;9340.626374945197;9414.19979301767;9592.218256705757;9656.468894210604;7175.569465832067;7414.62926853666;7621.847563048819;7625.961870190614;7682.270184332479;9039.231665308522;9572.282078843975;9704;9727.367721098106;9757.170640495637 05:17:48 INFO - PROCESS | 15735 | |3;mootools.html;1494.3798323695664;1519.498565473394;1695.7202061659827;1807.9005654689004;1836.9448916532508;8000.719974800883;8038.437309388345;8200.466969646968;8219.506829590222;8236;8201.753947381572;8266.751997440071;8289.088200297962;8299.211574900375;8320.91679083209;2333.288347054148;2365.763423657629;2375.904963801446;2377.6671266022686;2382.6783384243076;2322.918697845576;2341.7775311345395;2376.9286921392386;2382.344855164826;2389.5340408620327;2269.171752310411;2338.333574931145;2340.4850932794757;2349.3891588187107;2367;2302.735185453669;2330.8718020508863;2352.541254455382;2362.208660098852;2366.136360228513;2320.280712978982;2323.604987152188;2325.267540724666;2338.8596684199;2339.7309309429465;7922.7227047053075;8059.717909873127;8071.636776345079;8075.152109028585;8105.351571874236;4849.75751212438;4977.875553111201;4979.153543897546;4989.700617962898;5002.1746411842005;3349.1961929137074;3364.3103163851597;3410.5907291125222;3423.8972830815114;3454.2573346730574;1068.0654427376046;1075.376281756587;1104.6078642082025;1109.9944500277527;1131.7227279316621;11131.610393636265;11192.272502287326;11227.607033753779;11227.775444491064;11236.550537978554;4116.403121547419;4270.893227669271;4289.463817022872;4294.871153865389;4377.1683380157665;8947.239484643878;8947.373683842068;8947.463152210888;8948.642054317885;8950.776230594158;4755.690880092783;4766.523347665206;4773.069251495995;4779.784909679072;4783.5933945614315;4337.0892112656065;4363.6072753452345;4417.757023363746;4424.6902716810155;4434.224010798098;3585.0678823505555;3628.9455658165148;3653.214558869856;3661.8901432956523;3681.2637472505608;1126.7408496045791;1136.2557524821254;1149.4080548517352;1160.495184594704;1165.143619439711;1298.3443361102584;1302.0299876592;1313.1398933698442;1316.5918565244613;1317.8682131786745;7527.962360188273;7575.583342916082;7787.29914307715;7790.649420776079;7808.414368922354;1137.6871360375796;1143.2740209966564;1146.0461408141778;1148.8678801937717;1150.5455345138623;5841.2990441146485;5894.793682221188;6023.548233882477;6024;6026.638401695912;9320.90679093214;10223.693289201336;10237.18102551794;10270.743231419274;10280;10044.799104017879;10105.646302379528;10114.241431892637;10125;10151.847722284172;7492.587907665131;7669.233076692286;7685.7309994151055;7700.922990770021;7708.267714567107;7701.537907725555;7726.690932362642;7800.804979875322;7813;7851.646675899484;8851.247643950337;8905.910940890508;8935.329850261387;8976.371653984159;9088.136627020422;9029.774255643399;9101.544922753968;9181.265498760216;9183.494907779868;9277.536123193679;7210.855782884418;7311;7320.487565870338;7322.96338518304;7336.523125996793;7827.139014708264;7845.089848087447;7934.365250780039;7937.087234968052;7939.206079392246;6692.498062645223;7110.25342339047;7428.925710743039;7581.810454738676;7617.581033043236;6981.476389270927;7035;7203.783886483414;7268.709251630087;7315.524490908074;7186.784396468114;7215.819604509929;7219.819504512429;7274.4907856449545;7281.417486600953;6636.13730215069;6641.269460359454;6696;6712.362325579063;6715.563488373436;6807.183138023469;6812.727490900308;6845.110135682528;6861.485388595976;6873.415759660485 05:17:48 INFO - PROCESS | 15735 | |4;prototype.html;351.5096440465551;351.60620105481854;352.0810684114461;354.4488320661371;356.71997481976655;6263.624182549044;6295.370462953702;6302.936970630298;6322.841928951779;6497.77257795976;6287.591306565081;6331.715072821723;6337;6339.11252424661;6356.809295721136;4845.733484658343;4848.684835485682;4860.708357498544;4864.610831133501;4875.829345972892;4853.296272040552;4856.5629093381585;4859.465458799529;4864.100141473821;4877.70733755974;4602.447706275251;4641.164590373732;4764.618830493552;4772.141014617368;4774.40319960005;4718.4809670936165;4736.928946065812;4744.810207591692;4757.310190022462;4759;4151.12826306476;4158.563350848178;4165.12532368203;4165.520965088993;4166.270902592034;5832.387599302097;5902.026165682657;5920.555958303102;5929.703514824241;5929.851753706149;5485.61600687952;5549.916751248735;5554.0835762099205;5559.110542313251;5576.079946808772;6633.469322454241;6634.834129146761;6635.668216589152;6637.336266373372;6662.4336931360895;4611.400517932647;4616.261398176276;4617.515160908123;4618.8152473901;4622.237330840408;6834.1457317835275;6891.241963384024;6952.895706564456;6987.89518157228;6995.335443132894;4737.24204127338;4740.360051393087;4740.952590474051;4744.478107408182;4760.45254795696;4804.927926081112;4806.831760888422;4809.134355815917;4812.735299558488;4823.300621409876;5548.195511650869;5562.415946325658;5565.387807341189;5576.6096373254295;5590.552755779528;6616.470682345401;6715.597064176165;6749.08887300218;6771.052052712625;6775.830604234933;1684.8483636472777;1711.4694444722177;1712.3065158610782;1713.2632967823956;1714.8113707492166;1139.6979800352913;1142.965711028654;1143.5254369436757;1161.2451906260828;1162.598903378333;6270.655113968775;6280.089387038854;6285.465735412541;6292.1505596743855;6301.936980630227;6800.761973330909;6803.319668033157;6811.591304521745;6826.044353790473;6829.214640316328;6122.234720659918;6157.0456579230295;6279;6345.714442850082;6414.775482858077;3739.0652336915773;3745.2509498099944;3753.042974041602;3757.3800322946954;3773.962260377416;7269.600171990485;7274.418046556263;7287.781366559012;7301.160366557808;7304.306090921354;6982.930170698228;7056.470764692566;7172.928270717331;7182.748603798842;7185.89221161683;7295.854082918312;7317.597532135784;7328.78013659591;7328.890066649004;7334.596597187206;6885.345892140239;6937.583744975318;6940.167179938439;6941.444684425132;6964.686589103401;6736.259011508828;6879.140107486564;6894.13823272091;6903.0680858083515;6912.412444942035;7321.6705248265025;7333.193348731528;7345.77962661121;7349.4855360124275;7430.888536671846;4758.976205118952;4781.187198176388;4787.40157480315;4791.257355109963;4799.304100905419;6848.589084654936;6980.092587963532;6980.197277313174;6999.755008574675;7005.22942476317;6743.662816859235;6757.087793148059;6757.797266082025;6769.695363708546;6789.830254243683;6529.118568993315;6730.6971186297715;6735.797926062226;6747.257801641717;6769.221539522821;6614.305497922649;6628.668566571749;6631.33686631333;6640.701168447335;6660.0675905374255;6749.898751518633;6806.183258008872;6814.863702725818;6820.556663816836;6825.532510510264;6534.379233972765;6621.039949207242;6630.867382652224;6636;6643.966780166068 05:17:48 INFO - PROCESS | 15735 | |5;yui.html;673.6631684157918;689.4449967775938;733.6955163607104;821.1524070840609;833.795720048588;12675.556355527548;12773;12796.168249063816;12798.616041518746;12844.22934623922;12595.181313214634;12756.744865102692;13930.51243206488;14213;14253.714925701479;815.7348861619982;823.6417158536026;830.2237408023487;830.5805568188057;838.4508147163588;834.5701963488808;839.9622017009249;841.221869770463;841.4320333774708;843.026304618167;858.5192292316292;858.5621333120091;859.9054104048549;860.4923095373729;862.9482231066124;845.1464021338431;848.6902280667574;850.9702160424356;857.3227150551057;859.2867919626694;626.7493002798872;630.5113537008855;633.0757094641829;633.9049142628596;634.6572850660638;13483.056186066979;13522.594322170351;13598;13615.387307571184;13624.97812664054;12254.938725306405;12397.938010309981;12435.378231088409;12604.55884044054;12791.680207994781;10216.289019172853;10387.948060259725;10392.168626509936;10529.947350263199;10598.364098154058;3573.803440810754;3583.94624080639;3589.7128229741556;3614.584322802859;3726.2361215950937;46097;46716.532834671896;47193.528064719256;47217.527824721656;47690.04619907617;9935.850962235572;9957.502124893872;9959.850602240973;10099.394036357842;10113.69658910234;16152.192390380435;16363.263653135638;16424;16474.505764827074;16507.33970641161;7650.19672934345;7707.113681926538;7723.729669461654;7727.729529466442;7742.574158421341;4213.494380674339;4319.33050377192;4333.653307735373;4356.760378179167;4435.6229720473475;3090.428270769915;3094.4894092474487;3095.334503081848;3096.6284045914635;3113.595232619745;600.0668959767517;611.810338794975;619.2414292491661;627.5324882962223;628.2398298059308;493.97777100030584;608.89344364736;617.9382061793874;640.4012248547623;665.5938781305642;8195.34437245019;8302.584870756438;8415.747527574182;8452.535110568977;8545.273651739548;506.61750378464023;607.3198018219622;610.5817515002149;638.4573112854036;698.8951657251453;3965.560145324208;4052.452918855976;4098.8360465581045;4107.812624690783;4189.539150693421;51591.48408515942;52935.470645293826;53157.73421132947;53417.46582534203;53471;49174.770630734514;49196.26205606919;49883.501164988615;50074.24888626674;50443;44289.55710442919;45178.54821451743;45206;45345.773271134094;45445.772771136595;7943.563104029334;8014.83970320602;8034.83930321402;8041.075276343061;8127.065387480279;31158.532622011142;32452.35095298128;32930.67069329276;32980.50529242111;33117.66882331146;39052;39531;41011.7949410251;43692.126157476036;44193.11613767771;10671.413072281099;10894.67315980522;10978.560857565928;11014.229003969645;11671.824922625998;11879.940600296943;12027.338496382783;12417.689557761129;12502.499900003899;12503.37483125822;11194.727214888046;11647.126465514952;11800;11829.17195796286;12291.262524248574;11410.201285909907;11741.589044383405;11810.291382517076;12135.271883687006;12175.695607609881;11112.388818615054;11177.832332514856;11264.718382040515;11479.8278025828;11547.653570392902;9286.34995550332;9451.196648284973;9455.338126331366;9461.763455913657;9907.554160062671;8746.65013399457;9448.669296574586;9449.14957653787;9548.761280968032;10052.597896084075 05:17:48 INFO - PROCESS | 15735 | __end_tp_report 05:17:48 INFO - PROCESS | 15735 | __start_cc_report 05:17:48 INFO - PROCESS | 15735 | _x_x_mozilla_cycle_collect,314 05:17:48 INFO - PROCESS | 15735 | __end_cc_report 05:17:48 INFO - PROCESS | 15735 | __startTimestamp1453209468446__endTimestamp 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | ------- Summary: start ------- 05:17:48 INFO - PROCESS | 15735 | Number of tests: 6 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | [#0] dojo.html Cycles:165 Average:5367.27 Median:5528.45 stddev:587.21 (10.6%) stddev-sans-first:564.97 05:17:48 INFO - PROCESS | 15735 | Values: 3247.4 3255.4 3295.6 3303.2 3312.4 5243.7 5301.8 5377.1 5383.7 5385.7 5303.3 5312.1 5364.5 5429.4 5439.6 4935.6 4966.1 5017.9 5033.3 5045.1 4911.1 4980.3 4984.3 4989.7 5011.8 4833.9 4874.4 4917.4 4918.9 4926.0 4846.3 4854.1 4882.4 4928.7 4961.4 4874.1 4916.7 4917.5 4920.5 4921.3 5229.6 5257.2 5270.4 5284.8 5304.8 5710.3 5801.6 5877.3 5886.7 5929.2 5752.4 5754.5 5761.4 5780.3 5781.9 5335.9 5358.5 5364.4 5386.5 5386.6 5799.6 6045.6 6069.0 6088.4 6128.3 5634.1 5652.8 5657.2 5665.0 5671.3 5656.9 5693.7 5744.8 5753.7 5757.2 5628.8 5755.9 5766.4 5821.3 5838.9 5810.4 5850.2 5861.4 5867.7 5875.0 4436.9 4478.2 4496.3 4503.0 4535.7 3995.1 3998.0 4024.9 4026.8 4067.2 5416.0 5485.5 5495.9 5516.3 5528.4 5654.6 5752.9 5846.8 5884.8 5902.3 5328.8 5338.0 5375.6 5376.7 5428.0 4873.7 4881.4 4882.6 4903.0 4920.4 5842.9 5923.5 6004.5 6013.1 6062.5 5825.9 5826.6 5829.8 5847.6 5881.3 5980.3 6009.1 6013.3 6025.8 6050.8 5679.1 5680.8 5704.4 5787.9 5792.8 5732.5 5752.5 5764.4 5775.2 5806.1 5602.2 5609.5 5611.9 5615.7 5646.0 5549.4 5619.8 5629.6 5650.6 5720.6 5423.2 5445.4 5467.2 5471.1 5476.2 5515.9 5562.6 5568.8 5577.2 5620.3 5437.8 5500.4 5553.6 5561.5 5564.6 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | [#1] ext.html Cycles:180 Average:49142.18 Median:21766.80 stddev:87782.99 (403.3%) stddev-sans-first:87953.32 05:17:48 INFO - PROCESS | 15735 | Values: 517.0 546.5 555.8 559.6 580.2 34923.1 35773.5 35971.6 36030.0 36109.3 39393.4 39957.2 40089.6 40251.8 40519.6 8472.4 8586.4 8619.7 8658.5 8663.9 8391.9 8475.2 8500.4 8619.7 8633.7 8652.5 8726.2 8762.4 8795.7 8809.5 8674.9 8742.5 8755.6 8764.1 8766.5 8648.0 8703.0 8765.7 8770.1 8787.0 40259.2 40630.6 40707.6 40760.4 40829.8 2679.3 3166.3 3206.6 3501.0 4024.6 26571.0 27490.6 28803.7 29348.3 29549.9 3895.2 3971.6 4021.0 4048.7 4173.3 228863.0 231853.8 231901.0 232307.0 233806.0 55801.0 56356.0 56679.0 56762.0 56835.4 64910.4 66254.7 66737.0 67009.3 67033.0 14149.3 14289.9 14316.6 14337.5 14457.1 10014.1 10056.6 10077.9 10097.2 10117.1 20489.7 20875.8 20883.9 20893.2 20933.2 8109.1 8213.7 8222.5 8244.3 8342.7 938.7 956.6 1021.8 1044.9 1047.4 26296.5 26366.9 26381.1 26440.3 26475.6 964.4 1111.8 1128.5 1135.7 1139.9 13848.6 13893.4 14153.0 14181.6 14264.8 415628.0 417661.0 418065.0 423123.0 424290.0 55229.7 55270.1 55643.4 56060.4 56181.4 1312.6 1315.9 1335.9 1336.7 1338.4 26992.0 28097.3 28320.4 29504.6 30499.6 51141.7 51829.0 51923.5 52006.7 52093.5 317466.0 318224.0 319568.0 321562.0 322821.0 42974.0 43661.0 43686.8 43691.8 44526.8 39161.2 40423.6 40440.0 40610.4 41326.0 27394.0 27420.2 27467.2 27592.3 30153.2 38604.6 39562.0 40226.4 40324.8 40922.4 33866.3 33991.3 34275.7 34428.1 34613.1 29526.1 30282.2 35003.0 36546.9 36804.3 24987.0 25422.7 25438.7 25523.0 25691.2 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | [#2] jquery.html Cycles:180 Average:26080.25 Median:4916.83 stddev:83550.52 (1699.3%) stddev-sans-first:83762.59 05:17:48 INFO - PROCESS | 15735 | Values: 369.4 370.3 370.7 372.0 375.4 13704.5 14952.8 15706.6 17224.3 18152.9 15500.7 15793.4 16227.4 16232.8 16391.2 5147.3 5520.7 5523.4 5526.8 5531.0 5314.9 5391.3 5494.2 5495.6 5560.7 5489.5 5499.7 5518.6 5539.4 5543.8 5313.2 5424.3 5459.1 5490.9 5503.8 4785.3 4871.7 4904.9 4909.7 4924.0 19943.9 20218.0 20518.0 20663.7 20677.5 2090.6 2103.1 2154.9 2212.9 2268.1 12601.2 12736.4 12789.2 12913.5 13036.9 1797.2 1818.2 1825.4 1877.1 1918.0 53077.2 53844.7 53964.2 57010.7 57021.1 9751.1 9912.8 9950.0 10011.9 10085.1 12791.3 13160.3 13219.7 13226.0 13271.4 6632.4 6654.0 6717.3 6736.2 6852.2 6117.9 6141.2 6264.8 6271.3 6513.2 4435.6 4450.9 4498.3 4500.2 4524.3 1855.1 1919.2 1931.8 1941.7 1951.4 806.8 903.4 907.0 1058.7 1074.6 15386.9 15791.7 16299.6 16411.4 16507.0 908.5 933.7 950.4 956.8 996.4 8832.1 8926.4 8948.0 9028.2 9034.2 396124.0 405037.0 570276.0 572887.0 579589.0 60088.1 64011.4 64565.4 65610.3 67750.3 1100.5 1129.4 1144.5 1151.1 1154.4 15117.4 15145.5 15185.4 15310.3 15757.1 29864.3 32043.7 32203.7 33543.5 34149.0 35271.8 35484.8 35637.0 36886.0 37327.4 7112.0 7220.3 7504.1 7591.6 7781.6 9982.9 10870.5 10982.9 11222.2 11262.4 9147.9 9161.3 9460.1 9561.3 9895.6 9493.9 9711.2 9762.0 10042.1 10130.0 9218.7 9340.6 9414.2 9592.2 9656.5 7175.6 7414.6 7621.8 7626.0 7682.3 9039.2 9572.3 9704.0 9727.4 9757.2 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | [#3] mootools.html Cycles:180 Average:5720.27 Median:4978.51 stddev:2981.31 (59.9%) stddev-sans-first:2972.76 05:17:48 INFO - PROCESS | 15735 | Values: 1494.4 1519.5 1695.7 1807.9 1836.9 8000.7 8038.4 8200.5 8219.5 8236.0 8201.8 8266.8 8289.1 8299.2 8320.9 2333.3 2365.8 2375.9 2377.7 2382.7 2322.9 2341.8 2376.9 2382.3 2389.5 2269.2 2338.3 2340.5 2349.4 2367.0 2302.7 2330.9 2352.5 2362.2 2366.1 2320.3 2323.6 2325.3 2338.9 2339.7 7922.7 8059.7 8071.6 8075.2 8105.4 4849.8 4977.9 4979.2 4989.7 5002.2 3349.2 3364.3 3410.6 3423.9 3454.3 1068.1 1075.4 1104.6 1110.0 1131.7 11131.6 11192.3 11227.6 11227.8 11236.6 4116.4 4270.9 4289.5 4294.9 4377.2 8947.2 8947.4 8947.5 8948.6 8950.8 4755.7 4766.5 4773.1 4779.8 4783.6 4337.1 4363.6 4417.8 4424.7 4434.2 3585.1 3628.9 3653.2 3661.9 3681.3 1126.7 1136.3 1149.4 1160.5 1165.1 1298.3 1302.0 1313.1 1316.6 1317.9 7528.0 7575.6 7787.3 7790.6 7808.4 1137.7 1143.3 1146.0 1148.9 1150.5 5841.3 5894.8 6023.5 6024.0 6026.6 9320.9 10223.7 10237.2 10270.7 10280.0 10044.8 10105.6 10114.2 10125.0 10151.8 7492.6 7669.2 7685.7 7700.9 7708.3 7701.5 7726.7 7800.8 7813.0 7851.6 8851.2 8905.9 8935.3 8976.4 9088.1 9029.8 9101.5 9181.3 9183.5 9277.5 7210.9 7311.0 7320.5 7323.0 7336.5 7827.1 7845.1 7934.4 7937.1 7939.2 6692.5 7110.3 7428.9 7581.8 7617.6 6981.5 7035.0 7203.8 7268.7 7315.5 7186.8 7215.8 7219.8 7274.5 7281.4 6636.1 6641.3 6696.0 6712.4 6715.6 6807.2 6812.7 6845.1 6861.5 6873.4 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | [#4] prototype.html Cycles:180 Average:5610.13 Median:6302.44 stddev:1703.21 (27.0%) stddev-sans-first:1661.62 05:17:48 INFO - PROCESS | 15735 | Values: 351.5 351.6 352.1 354.4 356.7 6263.6 6295.4 6302.9 6322.8 6497.8 6287.6 6331.7 6337.0 6339.1 6356.8 4845.7 4848.7 4860.7 4864.6 4875.8 4853.3 4856.6 4859.5 4864.1 4877.7 4602.4 4641.2 4764.6 4772.1 4774.4 4718.5 4736.9 4744.8 4757.3 4759.0 4151.1 4158.6 4165.1 4165.5 4166.3 5832.4 5902.0 5920.6 5929.7 5929.9 5485.6 5549.9 5554.1 5559.1 5576.1 6633.5 6634.8 6635.7 6637.3 6662.4 4611.4 4616.3 4617.5 4618.8 4622.2 6834.1 6891.2 6952.9 6987.9 6995.3 4737.2 4740.4 4741.0 4744.5 4760.5 4804.9 4806.8 4809.1 4812.7 4823.3 5548.2 5562.4 5565.4 5576.6 5590.6 6616.5 6715.6 6749.1 6771.1 6775.8 1684.8 1711.5 1712.3 1713.3 1714.8 1139.7 1143.0 1143.5 1161.2 1162.6 6270.7 6280.1 6285.5 6292.2 6301.9 6800.8 6803.3 6811.6 6826.0 6829.2 6122.2 6157.0 6279.0 6345.7 6414.8 3739.1 3745.3 3753.0 3757.4 3774.0 7269.6 7274.4 7287.8 7301.2 7304.3 6982.9 7056.5 7172.9 7182.7 7185.9 7295.9 7317.6 7328.8 7328.9 7334.6 6885.3 6937.6 6940.2 6941.4 6964.7 6736.3 6879.1 6894.1 6903.1 6912.4 7321.7 7333.2 7345.8 7349.5 7430.9 4759.0 4781.2 4787.4 4791.3 4799.3 6848.6 6980.1 6980.2 6999.8 7005.2 6743.7 6757.1 6757.8 6769.7 6789.8 6529.1 6730.7 6735.8 6747.3 6769.2 6614.3 6628.7 6631.3 6640.7 6660.1 6749.9 6806.2 6814.9 6820.6 6825.5 6534.4 6621.0 6630.9 6636.0 6644.0 05:17:48 INFO - PROCESS | 15735 | 05:17:48 INFO - PROCESS | 15735 | [#5] yui.html Cycles:180 Average:13362.07 Median:45275.89 stddev:15094.50 (33.3%) stddev-sans-first:15106.77 05:17:48 INFO - PROCESS | 15735 | Values: 673.7 689.4 733.7 821.2 833.8 12675.6 12773.0 12796.2 12798.6 12844.2 12595.2 12756.7 13930.5 14213.0 14253.7 815.7 823.6 830.2 830.6 838.5 834.6 840.0 841.2 841.4 843.0 858.5 858.6 859.9 860.5 862.9 845.1 848.7 851.0 857.3 859.3 626.7 630.5 633.1 633.9 634.7 13483.1 13522.6 13598.0 13615.4 13625.0 12254.9 12397.9 12435.4 12604.6 12791.7 10216.3 10387.9 10392.2 10529.9 10598.4 3573.8 3583.9 3589.7 3614.6 3726.2 46097.0 46716.5 47193.5 47217.5 47690.0 9935.9 9957.5 9959.9 10099.4 10113.7 16152.2 16363.3 16424.0 16474.5 16507.3 7650.2 7707.1 7723.7 7727.7 7742.6 4213.5 4319.3 4333.7 4356.8 4435.6 3090.4 3094.5 3095.3 3096.6 3113.6 600.1 611.8 619.2 627.5 628.2 494.0 608.9 617.9 640.4 665.6 8195.3 8302.6 8415.7 8452.5 8545.3 506.6 607.3 610.6 638.5 698.9 3965.6 4052.5 4098.8 4107.8 4189.5 51591.5 52935.5 53157.7 53417.5 53471.0 49174.8 49196.3 49883.5 50074.2 50443.0 44289.6 45178.5 45206.0 45345.8 45445.8 7943.6 8014.8 8034.8 8041.1 8127.1 31158.5 32452.4 32930.7 32980.5 33117.7 39052.0 39531.0 41011.8 43692.1 44193.1 10671.4 10894.7 10978.6 11014.2 11671.8 11879.9 12027.3 12417.7 12502.5 12503.4 11194.7 11647.1 11800.0 11829.2 12291.3 11410.2 11741.6 11810.3 12135.3 12175.7 11112.4 11177.8 11264.7 11479.8 11547.7 9286.3 9451.2 9455.3 9461.8 9907.6 8746.7 9448.7 9449.1 9548.8 10052.6 05:17:48 INFO - PROCESS | 15735 | -------- Summary: end -------- 05:17:48 INFO - PROCESS | 15735 | 05:17:49 INFO - TEST-INFO | 15735: exit 0 05:17:49 INFO - TEST-OK | dromaeo_css | took 1110920ms 05:17:49 INFO - TEST-START | kraken 05:17:49 INFO - operating with platform_type : linux_ 05:17:49 INFO - Initialising browser for kraken test... 05:17:49 INFO - TEST-INFO | started process 15980 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcNF629/profile http://localhost:47527/getInfo.html) 05:17:52 INFO - PROCESS | 15980 | 05:17:52 INFO - PROCESS | 15980 | (process:16054): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:17:53 INFO - PROCESS | 15980 | __metrics Screen width/height:1600/1200 05:17:53 INFO - PROCESS | 15980 | colorDepth:24 05:17:53 INFO - PROCESS | 15980 | Browser inner width/height: 1024/697 05:17:53 INFO - PROCESS | 15980 | __metrics 05:17:53 INFO - PROCESS | 15980 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:17:54 INFO - TEST-INFO | 15980: exit 0 05:17:54 INFO - Browser initialized. 05:17:54 INFO - Running cycle 1/1 for kraken test... 05:17:54 INFO - TEST-INFO | started process 16102 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcNF629/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:55 INFO - PROCESS | 16102 | -- checkerboarding starts below -- 05:17:55 INFO - PROCESS | 16102 | RENDERTRACE 0.045054 rect red 0 0 10 10 // viewport 05:17:55 INFO - PROCESS | 16102 | RENDERTRACE 42.9247 rect brown 0 0 10 10 // page 05:17:55 INFO - PROCESS | 16102 | RENDERTRACE 42.9594 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:17:55 INFO - PROCESS | 16102 | Checkerboarded for 1 frames (50.3147 ms), 100 peak, 1 severity. 05:17:55 INFO - PROCESS | 16102 | 05:17:55 INFO - PROCESS | 16102 | (process:16159): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:06 INFO - PROCESS | 16102 | RSS: Main: 150335488 05:18:06 INFO - PROCESS | 16102 | 05:18:08 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47527/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:09 INFO - PROCESS | 16102 | RSS: Main: 150732800 05:18:09 INFO - PROCESS | 16102 | 05:18:11 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47527/tests/kraken/driver.html?testName=audio-dft) 05:18:12 INFO - PROCESS | 16102 | RSS: Main: 154333184 05:18:12 INFO - PROCESS | 16102 | 05:18:15 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47527/tests/kraken/driver.html?testName=audio-fft) 05:18:15 INFO - PROCESS | 16102 | RSS: Main: 147595264 05:18:15 INFO - PROCESS | 16102 | 05:18:17 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47527/tests/kraken/driver.html?testName=audio-oscillator) 05:18:18 INFO - PROCESS | 16102 | RSS: Main: 149196800 05:18:18 INFO - PROCESS | 16102 | 05:18:20 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:21 INFO - PROCESS | 16102 | RSS: Main: 149020672 05:18:21 INFO - PROCESS | 16102 | 05:18:24 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47527/tests/kraken/driver.html?testName=imaging-darkroom) 05:18:24 INFO - PROCESS | 16102 | RSS: Main: 147562496 05:18:24 INFO - PROCESS | 16102 | 05:18:28 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47527/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:28 INFO - PROCESS | 16102 | RSS: Main: 147808256 05:18:28 INFO - PROCESS | 16102 | 05:18:31 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47527/tests/kraken/driver.html?testName=json-parse-financial) 05:18:32 INFO - PROCESS | 16102 | RSS: Main: 148205568 05:18:32 INFO - PROCESS | 16102 | 05:18:33 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:34 INFO - PROCESS | 16102 | RSS: Main: 149696512 05:18:34 INFO - PROCESS | 16102 | 05:18:36 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:36 INFO - PROCESS | 16102 | RSS: Main: 149839872 05:18:36 INFO - PROCESS | 16102 | 05:18:38 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:39 INFO - PROCESS | 16102 | RSS: Main: 149831680 05:18:39 INFO - PROCESS | 16102 | 05:18:41 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:42 INFO - PROCESS | 16102 | RSS: Main: 148430848 05:18:42 INFO - PROCESS | 16102 | 05:18:45 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:45 INFO - PROCESS | 16102 | RSS: Main: 150003712 05:18:45 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:47527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47527/tests/kraken/driver.html?testName=ai-astar) 05:18:47 INFO - PROCESS | 16102 | RSS: Main: 149573632 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | __start_tp_report 05:18:47 INFO - PROCESS | 16102 | _x_x_mozilla_page_load 05:18:47 INFO - PROCESS | 16102 | _x_x_mozilla_page_load_details 05:18:47 INFO - PROCESS | 16102 | |i|pagename|runs| 05:18:47 INFO - PROCESS | 16102 | |0;ai-astar;110;106;110;110;112;123;111;111;110;111 05:18:47 INFO - PROCESS | 16102 | |1;audio-beat-detection;153;124;151;158;123;150;151;125;166;129 05:18:47 INFO - PROCESS | 16102 | |2;audio-dft;163;163;165;160;162;162;163;165;172;163 05:18:47 INFO - PROCESS | 16102 | |3;audio-fft;72;74;72;73;73;73;137;71;73;71 05:18:47 INFO - PROCESS | 16102 | |4;audio-oscillator;96;95;138;95;96;95;137;95;97;142 05:18:47 INFO - PROCESS | 16102 | |5;imaging-gaussian-blur;110;110;109;109;109;110;113;109;111;109 05:18:47 INFO - PROCESS | 16102 | |6;imaging-darkroom;148;146;147;147;148;147;148;148;149;147 05:18:47 INFO - PROCESS | 16102 | |7;imaging-desaturate;96;96;96;96;96;96;97;96;97;97 05:18:47 INFO - PROCESS | 16102 | |8;json-parse-financial;61;59;58;59;61;62;60;59;66;56 05:18:47 INFO - PROCESS | 16102 | |9;json-stringify-tinderbox;68;68;68;68;69;69;70;68;74;70 05:18:47 INFO - PROCESS | 16102 | |10;stanford-crypto-aes;82;82;90;82;83;89;82;82;83;81 05:18:47 INFO - PROCESS | 16102 | |11;stanford-crypto-ccm;116;121;122;118;119;115;111;126;136;121 05:18:47 INFO - PROCESS | 16102 | |12;stanford-crypto-pbkdf2;133;144;138;146;149;132;146;145;145;148 05:18:47 INFO - PROCESS | 16102 | |13;stanford-crypto-sha256-iterative;67;68;70;66;65;66;67;67;67;67 05:18:47 INFO - PROCESS | 16102 | __end_tp_report 05:18:47 INFO - PROCESS | 16102 | __start_cc_report 05:18:47 INFO - PROCESS | 16102 | _x_x_mozilla_cycle_collect,741 05:18:47 INFO - PROCESS | 16102 | __end_cc_report 05:18:47 INFO - PROCESS | 16102 | __startTimestamp1453209527608__endTimestamp 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | ------- Summary: start ------- 05:18:47 INFO - PROCESS | 16102 | Number of tests: 14 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.38 (3.9%) stddev-sans-first:4.61 05:18:47 INFO - PROCESS | 16102 | Values: 110.0 106.0 110.0 110.0 112.0 123.0 111.0 111.0 110.0 111.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:151.00 stddev:16.03 (10.6%) stddev-sans-first:16.59 05:18:47 INFO - PROCESS | 16102 | Values: 153.0 124.0 151.0 158.0 123.0 150.0 151.0 125.0 166.0 129.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.22 (2.0%) stddev-sans-first:3.41 05:18:47 INFO - PROCESS | 16102 | Values: 163.0 163.0 165.0 160.0 162.0 162.0 163.0 165.0 172.0 163.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:20.44 (28.0%) stddev-sans-first:21.52 05:18:47 INFO - PROCESS | 16102 | Values: 72.0 74.0 72.0 73.0 73.0 73.0 137.0 71.0 73.0 71.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:95.00 stddev:21.02 (22.1%) stddev-sans-first:21.80 05:18:47 INFO - PROCESS | 16102 | Values: 96.0 95.0 138.0 95.0 96.0 95.0 137.0 95.0 97.0 142.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:1.29 (1.2%) stddev-sans-first:1.36 05:18:47 INFO - PROCESS | 16102 | Values: 110.0 110.0 109.0 109.0 109.0 110.0 113.0 109.0 111.0 109.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:18:47 INFO - PROCESS | 16102 | Values: 148.0 146.0 147.0 147.0 148.0 147.0 148.0 148.0 149.0 147.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:18:47 INFO - PROCESS | 16102 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 97.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.50 stddev:2.69 (4.4%) stddev-sans-first:2.83 05:18:47 INFO - PROCESS | 16102 | Values: 61.0 59.0 58.0 59.0 61.0 62.0 60.0 59.0 66.0 56.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:1.87 (2.7%) stddev-sans-first:1.94 05:18:47 INFO - PROCESS | 16102 | Values: 68.0 68.0 68.0 68.0 69.0 69.0 70.0 68.0 74.0 70.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.50 stddev:3.17 (3.8%) stddev-sans-first:3.31 05:18:47 INFO - PROCESS | 16102 | Values: 82.0 82.0 90.0 82.0 83.0 89.0 82.0 82.0 83.0 81.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.00 stddev:6.85 (5.7%) stddev-sans-first:7.07 05:18:47 INFO - PROCESS | 16102 | Values: 116.0 121.0 122.0 118.0 119.0 115.0 111.0 126.0 136.0 121.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:145.50 stddev:6.08 (4.2%) stddev-sans-first:5.36 05:18:47 INFO - PROCESS | 16102 | Values: 133.0 144.0 138.0 146.0 149.0 132.0 146.0 145.0 145.0 148.0 05:18:47 INFO - PROCESS | 16102 | 05:18:47 INFO - PROCESS | 16102 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.41 05:18:47 INFO - PROCESS | 16102 | Values: 67.0 68.0 70.0 66.0 65.0 66.0 67.0 67.0 67.0 67.0 05:18:47 INFO - PROCESS | 16102 | -------- Summary: end -------- 05:18:47 INFO - PROCESS | 16102 | 05:18:48 INFO - TEST-INFO | 16102: exit 0 05:18:48 INFO - TEST-OK | kraken | took 59470ms 05:18:48 INFO - TEST-START | v8_7 05:18:48 INFO - operating with platform_type : linux_ 05:18:48 INFO - Initialising browser for v8_7 test... 05:18:48 INFO - TEST-INFO | started process 16386 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRvuCk_/profile http://localhost:47527/getInfo.html) 05:18:52 INFO - PROCESS | 16386 | 05:18:52 INFO - PROCESS | 16386 | (process:16457): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:52 INFO - PROCESS | 16386 | __metrics Screen width/height:1600/1200 05:18:52 INFO - PROCESS | 16386 | colorDepth:24 05:18:52 INFO - PROCESS | 16386 | Browser inner width/height: 1024/697 05:18:52 INFO - PROCESS | 16386 | __metrics 05:18:53 INFO - PROCESS | 16386 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:18:53 INFO - TEST-INFO | 16386: exit 0 05:18:53 INFO - Browser initialized. 05:18:53 INFO - Running cycle 1/1 for v8_7 test... 05:18:53 INFO - TEST-INFO | started process 16505 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRvuCk_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:54 INFO - PROCESS | 16505 | -- checkerboarding starts below -- 05:18:54 INFO - PROCESS | 16505 | RENDERTRACE 0.042839 rect red 0 0 10 10 // viewport 05:18:54 INFO - PROCESS | 16505 | RENDERTRACE 66.5981 rect brown 0 0 10 10 // page 05:18:54 INFO - PROCESS | 16505 | RENDERTRACE 66.621 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:18:54 INFO - PROCESS | 16505 | Checkerboarded for 1 frames (68.615 ms), 100 peak, 0 severity. 05:18:55 INFO - PROCESS | 16505 | 05:18:55 INFO - PROCESS | 16505 | (process:16561): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:05 INFO - PROCESS | 16505 | RSS: Main: 149782528 05:19:05 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | Cycle 1(1): loaded http://localhost:47527/tests/v8_7/run.html (next: http://localhost:47527/tests/v8_7/run.html) 05:19:28 INFO - PROCESS | 16505 | RSS: Main: 145633280 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | __start_tp_report 05:19:28 INFO - PROCESS | 16505 | _x_x_mozilla_page_load 05:19:28 INFO - PROCESS | 16505 | _x_x_mozilla_page_load_details 05:19:28 INFO - PROCESS | 16505 | |i|pagename|runs| 05:19:28 INFO - PROCESS | 16505 | |0;Richards;166.14055490945339 05:19:28 INFO - PROCESS | 16505 | |1;DeltaBlue;188.11136192626034 05:19:28 INFO - PROCESS | 16505 | |2;Encrypt;279.01785714285717 05:19:28 INFO - PROCESS | 16505 | |3;Decrypt;5159.79381443299 05:19:28 INFO - PROCESS | 16505 | |4;RayTrace;1071.8113612004288 05:19:28 INFO - PROCESS | 16505 | |5;Earley;700.2801120448179 05:19:28 INFO - PROCESS | 16505 | |6;Boyer;12243.90243902439 05:19:28 INFO - PROCESS | 16505 | |7;RegExp;41714.28571428572 05:19:28 INFO - PROCESS | 16505 | |8;Splay;570.1254275940707 05:19:28 INFO - PROCESS | 16505 | |9;NavierStokes;4840.579710144928 05:19:28 INFO - PROCESS | 16505 | __end_tp_report 05:19:28 INFO - PROCESS | 16505 | __startTimestamp1453209568435__endTimestamp 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | ------- Summary: start ------- 05:19:28 INFO - PROCESS | 16505 | Number of tests: 10 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 166.1 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 188.1 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 279.0 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 5159.8 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 1071.8 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#5] Earley Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 700.3 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 12243.9 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#7] RegExp Cycles:1 Average:41714.29 Median:41714.29 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 41714.3 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#8] Splay Cycles:1 Average:570.13 Median:570.13 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 570.1 05:19:28 INFO - PROCESS | 16505 | 05:19:28 INFO - PROCESS | 16505 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:19:28 INFO - PROCESS | 16505 | Values: 4840.6 05:19:28 INFO - PROCESS | 16505 | -------- Summary: end -------- 05:19:28 INFO - PROCESS | 16505 | 05:19:29 INFO - TEST-INFO | 16505: exit 0 05:19:29 INFO - TEST-OK | v8_7 | took 40835ms 05:19:29 INFO - SUITE-END | took 1211s 05:19:29 INFO - Completed test suite (00:20:11) 05:19:29 INFO - Working with test: dromaeo_css 05:19:29 INFO - Generating results file: dromaeo_css 05:19:29 INFO - Working with test: kraken 05:19:29 INFO - Generating results file: kraken 05:19:29 INFO - javascript benchmark 05:19:29 INFO - Working with test: v8_7 05:19:29 INFO - Generating results file: v8_7 05:19:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:19:29 INFO - process_Request line: dromaeo_css 7008.21 graph.html#tests=[[72,64,43]] 05:19:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:29 INFO - process_Request line: kraken 1502.40 graph.html#tests=[[232,64,43]] 05:19:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:19:29 INFO - process_Request line: v8_7 20528.29 graph.html#tests=[[230,64,43]] 05:19:29 INFO - RETURN: dromaeo_css: 7008.21 05:19:29 INFO - RETURN: kraken: 1502.40 05:19:29 INFO - RETURN: v8_7: 20528.29 05:19:29 INFO - javascript benchmark 05:19:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3247.415465216261, 3255.430299697554, 3295.555100061491, 3303.2072302647366, 3312.3872083664523, 5243.711595862235, 5301.780590464191, 5377.085895397782, 5383.703896285708, 5385.703786291757, 5303.337082864642, 5312.096943519601, 5364.490373414529, 5429.4027656957805, 5439.646422982503, 4935.555799978001, 4966.056449274644, 5017.9247311290355, 5033.295338652591, 5045.117104506715, 4911.066897289504, 4980.252962055684, 4984.277279794428, 4989.725565093919, 5011.799528018875, 4833.927491087637, 4874.366332376786, 4917.40991081069, 4918.90162196754, 4925.950740492603, 4846.321514987904, 4854.101991131652, 4882.389701287339, 4928.654994150411, 4961.404631444249, 4874.073925954058, 4916.680415772999, 4917.459079501288, 4920.532549407836, 4921.286413470062, 5229.640293523711, 5257.211418287249, 5270.420253772082, 5284.81503147388, 5304.814331498417, 5710.2862142232225, 5801.564882633819, 5877.294724633029, 5886.705664716747, 5929.199558059693, 5752.424757524256, 5754.539636829044, 5761.395053519362, 5780.277465316835, 5781.942180578182, 5335.866603334947, 5358.544523715489, 5364.383095943938, 5386.5152136307925, 5386.622936394415, 5799.5650326225705, 6045.576809623284, 6069.0, 6088.360722124202, 6128.3258841527395, 5634.126710359901, 5652.802151924663, 5657.2079908811975, 5665.008623490872, 5671.319441667027, 5656.85857853557, 5693.68684722336, 5744.770209191585, 5753.741081651336, 5757.222774925332, 5628.774849005994, 5755.9424405756245, 5766.423357664284, 5821.301443826768, 5838.883222335529, 5810.360860305363, 5850.180974663551, 5861.443162899518, 5867.706614669335, 5875.001249787546, 4436.866893993185, 4478.171538265431, 4496.280595104768, 4502.977485112619, 4535.705179163344, 3995.1210733638554, 3997.960020399759, 4024.899377515527, 4026.832218656615, 4067.1662309226535, 5416.0, 5485.451454854483, 5495.945040549624, 5516.255305533782, 5528.44715528444, 5654.575906807006, 5752.856178595569, 5846.824595262149, 5884.823455296348, 5902.291724993029, 5328.786848526093, 5338.039152952506, 5375.569954403638, 5376.677399356051, 5428.022955867903, 4873.731944743002, 4881.438634557, 4882.584980276716, 4903.04390643821, 4920.3603531541385, 5842.8539286517325, 5923.49650279731, 6004.5496587755215, 6013.098035294741, 6062.484688801413, 5825.94174058271, 5826.592138550261, 5829.8251052468495, 5847.5906686533235, 5881.2942446906645, 5980.282366116094, 6009.068594367705, 6013.308469525886, 6025.8192254232445, 6050.757969681164, 5679.119736440858, 5680.801171958961, 5704.372519022987, 5787.94212057874, 5792.768289268382, 5732.484076433141, 5752.539796816328, 5764.394738552392, 5775.162601422686, 5806.129080637938, 5602.215689803349, 5609.49514543693, 5611.859703507445, 5615.691136987341, 5645.971770141287, 5549.38956714753, 5619.80330688424, 5629.605927585029, 5650.604457688087, 5720.599558030898, 5423.186522021729, 5445.373782014961, 5467.234587157722, 5471.06991811401, 5476.205950137128, 5515.917261241165, 5562.638428502134, 5568.777248909998, 5577.163425486209, 5620.269364982526, 5437.782488700408, 5500.367457742411, 5553.555715542828, 5561.499465048165, 5564.582656300713], "unit": "score", "name": "dojo.html", "value": 5330.136314816999}, {"lowerIsBetter": false, "replicates": [516.9819056333029, 546.461735190837, 555.7721334252957, 559.5747232103603, 580.213810287061, 34923.12692182694, 35773.46339804898, 35971.64028359719, 36030.0, 36109.27781444376, 39393.40909886354, 39957.20085598286, 40089.59910400895, 40251.798741006256, 40519.59480405195, 8472.406931514797, 8586.398952073358, 8619.655213791471, 8658.523781192032, 8663.913360866405, 8391.916080839204, 8475.237228649421, 8500.404971651988, 8619.698310559132, 8633.69782057628, 8652.48085114892, 8726.214640682338, 8762.386632935666, 8795.736127916141, 8809.515476648781, 8674.913250867474, 8742.475451472932, 8755.562221888911, 8764.079771623952, 8766.517841518715, 8648.0, 8703.0, 8765.693200738007, 8770.122987701243, 8787.0334263231, 40259.19481610381, 40630.593694063275, 40707.592924070676, 40760.38859417111, 40829.795851020855, 2679.3301674581353, 3166.3034132490816, 3206.64726880043, 3501.0, 4024.5975402459812, 26571.0, 27490.587641185397, 28803.711962880312, 29348.266293342625, 29549.852250738822, 3895.162540053902, 3971.6028397160344, 4020.959790402117, 4048.6761059115493, 4173.3114036184, 228863.0, 231853.84073079695, 231901.0, 232307.0, 233806.0, 55801.0, 56356.0, 56679.0, 56762.0, 56835.43164568301, 64910.35089649138, 66254.66872665702, 66737.0, 67009.32990670031, 67033.0, 14149.29253537319, 14289.857101429061, 14316.57050288493, 14337.498187563593, 14457.132572045712, 10014.098731114234, 10056.597736090474, 10077.899221007843, 10097.182507148636, 10117.140043096419, 20489.692654610193, 20875.79124208769, 20883.895580522305, 20893.164273429196, 20933.16267349289, 8109.148539403395, 8213.671453141927, 8222.465539739898, 8244.340452763765, 8342.666293348198, 938.6949241496404, 956.5552018311519, 1021.8211812932707, 1044.9320794148357, 1047.3872784421046, 26296.47407051848, 26366.86816565905, 26381.076662316726, 26440.338991524983, 26475.602865957026, 964.3683387381277, 1111.8499002634542, 1128.4752590045669, 1135.693362792058, 1139.880312567185, 13848.584542463743, 13893.374798133906, 14153.0, 14181.574552763434, 14264.786028209584, 415628.0, 417661.0, 418065.0, 423123.0, 424290.0, 55229.723851380484, 55270.06554770644, 55643.44356556464, 56060.43939560552, 56181.43818561844, 1312.6193403912757, 1315.9144655597356, 1335.9265240411871, 1336.692560711042, 1338.43785610044, 26992.0, 28097.297567560974, 28320.43359132847, 29504.557431638113, 30499.616441068203, 51141.74429127831, 51829.0, 51923.48076519187, 52006.73996630144, 52093.47906520886, 317466.0, 318224.0, 319568.0, 321562.0, 322821.0, 42974.0, 43661.0, 43686.781566091966, 43691.78154109209, 44526.77736611296, 39161.2167756649, 40423.59576404198, 40440.0, 40610.39084413677, 41326.0, 27394.0, 27420.17739467819, 27467.175984720492, 27592.310192244553, 30153.246168845955, 38604.613953861226, 39562.0, 40226.39660405038, 40324.79837600793, 40922.38616420697, 33866.322673546885, 33991.320173595894, 34275.65724342824, 34428.13929651779, 34613.13467163341, 29526.114216573536, 30282.242943925696, 35003.0, 36546.869948018364, 36804.26391472102, 24987.0, 25422.74577254204, 25438.745612543637, 25523.0, 25691.229263122135], "unit": "score", "name": "ext.html", "value": 18535.809797204445}, {"lowerIsBetter": false, "replicates": [369.36469272850695, 370.2613286493444, 370.73492452896176, 371.9795411252381, 375.363758429462, 13704.52034178804, 14952.775708364383, 15706.607334816636, 17224.3110275589, 18152.909235453837, 15500.689986200268, 15793.368265269404, 16227.432039878606, 16232.83767162328, 16391.18044097796, 5147.330846989896, 5520.696361700105, 5523.420040895709, 5526.806561770339, 5531.0, 5314.867128321785, 5391.29913111295, 5494.203340515623, 5495.560355171597, 5560.7219639018085, 5489.533389661883, 5499.697516636584, 5518.613697041209, 5539.446055394468, 5543.77824887004, 5313.229581710669, 5424.294841670558, 5459.071957767189, 5490.862728431801, 5503.7798488060425, 4785.258284965836, 4871.658983871131, 4904.94543673112, 4909.705417674951, 4923.950760492421, 19943.90028049865, 20218.0, 20518.0, 20663.690044649342, 20677.4830629234, 2090.560982193741, 2103.0956688623887, 2154.91380344786, 2212.9446763830874, 2268.1040988809327, 12601.243925364508, 12736.36318184087, 12789.168704034208, 12913.549665593262, 13036.86963130366, 1797.1912639312231, 1818.1545581304624, 1825.4432398118568, 1877.11775465531, 1917.990410047941, 53077.2038419424, 53844.73077634626, 53964.19053714197, 57010.71494642542, 57021.14468282979, 9751.122398984126, 9912.752181195383, 9949.950250248847, 10011.899881001096, 10085.142762865238, 12791.296478693575, 13160.276184809927, 13219.735605288033, 13226.0, 13271.402786874614, 6632.436242919406, 6653.9667301663185, 6717.261101278856, 6736.191657001191, 6852.211995620568, 6117.938820611737, 6141.232345956755, 6264.843378915563, 6271.341509141565, 6513.2184137902805, 4435.645148388121, 4450.933236001462, 4498.2577874650315, 4500.212462819059, 4524.298733696282, 1855.1466325490155, 1919.2418994497095, 1931.7681878174708, 1941.6505029094617, 1951.4243298227057, 806.8023334283138, 903.381183889025, 907.0022974727747, 1058.714147180257, 1074.6346242277507, 15386.9230653846, 15791.684166316609, 16299.59251018734, 16411.42560010394, 16507.0, 908.504864848659, 933.6918816790443, 950.4392408479031, 956.7608097975506, 996.352370958868, 8832.116788321116, 8926.419782714103, 8947.997638736646, 9028.232600228923, 9034.186923176945, 396124.0, 405037.0, 570276.0, 572887.0, 579589.0, 60088.098678519855, 64011.35988640147, 64565.44220134073, 65610.34389656043, 67750.32249677539, 1100.4937728644752, 1129.3788416370962, 1144.5193018932234, 1151.1021403305435, 1154.440096553171, 15117.395304188149, 15145.469908553148, 15185.392584296504, 15310.31103600363, 15757.13335766498, 29864.25339366533, 32043.67956320407, 32203.677963221005, 33543.49684754682, 34149.0, 35271.82364088163, 35484.82257588695, 35637.0, 36886.0, 37327.44008839815, 7111.964440177766, 7220.277972202738, 7504.1370242420635, 7591.62041897914, 7781.610919453891, 9982.900170998197, 10870.510827012646, 10982.945085274523, 11222.214444989098, 11262.436878155895, 9147.908520914705, 9161.331434886792, 9460.101290377403, 9561.330706850731, 9895.604175832887, 9493.85759213626, 9711.174550163316, 9762.0, 10042.096211341015, 10130.0, 9218.723438296862, 9340.626374945197, 9414.19979301767, 9592.218256705757, 9656.468894210604, 7175.569465832067, 7414.62926853666, 7621.847563048819, 7625.961870190614, 7682.270184332479, 9039.231665308522, 9572.282078843975, 9704.0, 9727.367721098106, 9757.170640495637], "unit": "score", "name": "jquery.html", "value": 8093.359174945231}, {"lowerIsBetter": false, "replicates": [1494.3798323695664, 1519.498565473394, 1695.7202061659827, 1807.9005654689004, 1836.9448916532508, 8000.719974800883, 8038.437309388345, 8200.466969646968, 8219.506829590222, 8236.0, 8201.753947381572, 8266.751997440071, 8289.088200297962, 8299.211574900375, 8320.91679083209, 2333.288347054148, 2365.763423657629, 2375.904963801446, 2377.6671266022686, 2382.6783384243076, 2322.918697845576, 2341.7775311345395, 2376.9286921392386, 2382.344855164826, 2389.5340408620327, 2269.171752310411, 2338.333574931145, 2340.4850932794757, 2349.3891588187107, 2367.0, 2302.735185453669, 2330.8718020508863, 2352.541254455382, 2362.208660098852, 2366.136360228513, 2320.280712978982, 2323.604987152188, 2325.267540724666, 2338.8596684199, 2339.7309309429465, 7922.7227047053075, 8059.717909873127, 8071.636776345079, 8075.152109028585, 8105.351571874236, 4849.75751212438, 4977.875553111201, 4979.153543897546, 4989.700617962898, 5002.1746411842005, 3349.1961929137074, 3364.3103163851597, 3410.5907291125222, 3423.8972830815114, 3454.2573346730574, 1068.0654427376046, 1075.376281756587, 1104.6078642082025, 1109.9944500277527, 1131.7227279316621, 11131.610393636265, 11192.272502287326, 11227.607033753779, 11227.775444491064, 11236.550537978554, 4116.403121547419, 4270.893227669271, 4289.463817022872, 4294.871153865389, 4377.1683380157665, 8947.239484643878, 8947.373683842068, 8947.463152210888, 8948.642054317885, 8950.776230594158, 4755.690880092783, 4766.523347665206, 4773.069251495995, 4779.784909679072, 4783.5933945614315, 4337.0892112656065, 4363.6072753452345, 4417.757023363746, 4424.6902716810155, 4434.224010798098, 3585.0678823505555, 3628.9455658165148, 3653.214558869856, 3661.8901432956523, 3681.2637472505608, 1126.7408496045791, 1136.2557524821254, 1149.4080548517352, 1160.495184594704, 1165.143619439711, 1298.3443361102584, 1302.0299876592, 1313.1398933698442, 1316.5918565244613, 1317.8682131786745, 7527.962360188273, 7575.583342916082, 7787.29914307715, 7790.649420776079, 7808.414368922354, 1137.6871360375796, 1143.2740209966564, 1146.0461408141778, 1148.8678801937717, 1150.5455345138623, 5841.2990441146485, 5894.793682221188, 6023.548233882477, 6024.0, 6026.638401695912, 9320.90679093214, 10223.693289201336, 10237.18102551794, 10270.743231419274, 10280.0, 10044.799104017879, 10105.646302379528, 10114.241431892637, 10125.0, 10151.847722284172, 7492.587907665131, 7669.233076692286, 7685.7309994151055, 7700.922990770021, 7708.267714567107, 7701.537907725555, 7726.690932362642, 7800.804979875322, 7813.0, 7851.646675899484, 8851.247643950337, 8905.910940890508, 8935.329850261387, 8976.371653984159, 9088.136627020422, 9029.774255643399, 9101.544922753968, 9181.265498760216, 9183.494907779868, 9277.536123193679, 7210.855782884418, 7311.0, 7320.487565870338, 7322.96338518304, 7336.523125996793, 7827.139014708264, 7845.089848087447, 7934.365250780039, 7937.087234968052, 7939.206079392246, 6692.498062645223, 7110.25342339047, 7428.925710743039, 7581.810454738676, 7617.581033043236, 6981.476389270927, 7035.0, 7203.783886483414, 7268.709251630087, 7315.524490908074, 7186.784396468114, 7215.819604509929, 7219.819504512429, 7274.4907856449545, 7281.417486600953, 6636.13730215069, 6641.269460359454, 6696.0, 6712.362325579063, 6715.563488373436, 6807.183138023469, 6812.727490900308, 6845.110135682528, 6861.485388595976, 6873.415759660485], "unit": "score", "name": "mootools.html", "value": 4696.409135725573}, {"lowerIsBetter": false, "replicates": [351.5096440465551, 351.60620105481854, 352.0810684114461, 354.4488320661371, 356.71997481976655, 6263.624182549044, 6295.370462953702, 6302.936970630298, 6322.841928951779, 6497.77257795976, 6287.591306565081, 6331.715072821723, 6337.0, 6339.11252424661, 6356.809295721136, 4845.733484658343, 4848.684835485682, 4860.708357498544, 4864.610831133501, 4875.829345972892, 4853.296272040552, 4856.5629093381585, 4859.465458799529, 4864.100141473821, 4877.70733755974, 4602.447706275251, 4641.164590373732, 4764.618830493552, 4772.141014617368, 4774.40319960005, 4718.4809670936165, 4736.928946065812, 4744.810207591692, 4757.310190022462, 4759.0, 4151.12826306476, 4158.563350848178, 4165.12532368203, 4165.520965088993, 4166.270902592034, 5832.387599302097, 5902.026165682657, 5920.555958303102, 5929.703514824241, 5929.851753706149, 5485.61600687952, 5549.916751248735, 5554.0835762099205, 5559.110542313251, 5576.079946808772, 6633.469322454241, 6634.834129146761, 6635.668216589152, 6637.336266373372, 6662.4336931360895, 4611.400517932647, 4616.261398176276, 4617.515160908123, 4618.8152473901, 4622.237330840408, 6834.1457317835275, 6891.241963384024, 6952.895706564456, 6987.89518157228, 6995.335443132894, 4737.24204127338, 4740.360051393087, 4740.952590474051, 4744.478107408182, 4760.45254795696, 4804.927926081112, 4806.831760888422, 4809.134355815917, 4812.735299558488, 4823.300621409876, 5548.195511650869, 5562.415946325658, 5565.387807341189, 5576.6096373254295, 5590.552755779528, 6616.470682345401, 6715.597064176165, 6749.08887300218, 6771.052052712625, 6775.830604234933, 1684.8483636472777, 1711.4694444722177, 1712.3065158610782, 1713.2632967823956, 1714.8113707492166, 1139.6979800352913, 1142.965711028654, 1143.5254369436757, 1161.2451906260828, 1162.598903378333, 6270.655113968775, 6280.089387038854, 6285.465735412541, 6292.1505596743855, 6301.936980630227, 6800.761973330909, 6803.319668033157, 6811.591304521745, 6826.044353790473, 6829.214640316328, 6122.234720659918, 6157.0456579230295, 6279.0, 6345.714442850082, 6414.775482858077, 3739.0652336915773, 3745.2509498099944, 3753.042974041602, 3757.3800322946954, 3773.962260377416, 7269.600171990485, 7274.418046556263, 7287.781366559012, 7301.160366557808, 7304.306090921354, 6982.930170698228, 7056.470764692566, 7172.928270717331, 7182.748603798842, 7185.89221161683, 7295.854082918312, 7317.597532135784, 7328.78013659591, 7328.890066649004, 7334.596597187206, 6885.345892140239, 6937.583744975318, 6940.167179938439, 6941.444684425132, 6964.686589103401, 6736.259011508828, 6879.140107486564, 6894.13823272091, 6903.0680858083515, 6912.412444942035, 7321.6705248265025, 7333.193348731528, 7345.77962661121, 7349.4855360124275, 7430.888536671846, 4758.976205118952, 4781.187198176388, 4787.40157480315, 4791.257355109963, 4799.304100905419, 6848.589084654936, 6980.092587963532, 6980.197277313174, 6999.755008574675, 7005.22942476317, 6743.662816859235, 6757.087793148059, 6757.797266082025, 6769.695363708546, 6789.830254243683, 6529.118568993315, 6730.6971186297715, 6735.797926062226, 6747.257801641717, 6769.221539522821, 6614.305497922649, 6628.668566571749, 6631.33686631333, 6640.701168447335, 6660.0675905374255, 6749.898751518633, 6806.183258008872, 6814.863702725818, 6820.556663816836, 6825.532510510264, 6534.379233972765, 6621.039949207242, 6630.867382652224, 6636.0, 6643.966780166068], "unit": "score", "name": "prototype.html", "value": 5057.77938931208}, {"lowerIsBetter": false, "replicates": [673.6631684157918, 689.4449967775938, 733.6955163607104, 821.1524070840609, 833.795720048588, 12675.556355527548, 12773.0, 12796.168249063816, 12798.616041518746, 12844.22934623922, 12595.181313214634, 12756.744865102692, 13930.51243206488, 14213.0, 14253.714925701479, 815.7348861619982, 823.6417158536026, 830.2237408023487, 830.5805568188057, 838.4508147163588, 834.5701963488808, 839.9622017009249, 841.221869770463, 841.4320333774708, 843.026304618167, 858.5192292316292, 858.5621333120091, 859.9054104048549, 860.4923095373729, 862.9482231066124, 845.1464021338431, 848.6902280667574, 850.9702160424356, 857.3227150551057, 859.2867919626694, 626.7493002798872, 630.5113537008855, 633.0757094641829, 633.9049142628596, 634.6572850660638, 13483.056186066979, 13522.594322170351, 13598.0, 13615.387307571184, 13624.97812664054, 12254.938725306405, 12397.938010309981, 12435.378231088409, 12604.55884044054, 12791.680207994781, 10216.289019172853, 10387.948060259725, 10392.168626509936, 10529.947350263199, 10598.364098154058, 3573.803440810754, 3583.94624080639, 3589.7128229741556, 3614.584322802859, 3726.2361215950937, 46097.0, 46716.532834671896, 47193.528064719256, 47217.527824721656, 47690.04619907617, 9935.850962235572, 9957.502124893872, 9959.850602240973, 10099.394036357842, 10113.69658910234, 16152.192390380435, 16363.263653135638, 16424.0, 16474.505764827074, 16507.33970641161, 7650.19672934345, 7707.113681926538, 7723.729669461654, 7727.729529466442, 7742.574158421341, 4213.494380674339, 4319.33050377192, 4333.653307735373, 4356.760378179167, 4435.6229720473475, 3090.428270769915, 3094.4894092474487, 3095.334503081848, 3096.6284045914635, 3113.595232619745, 600.0668959767517, 611.810338794975, 619.2414292491661, 627.5324882962223, 628.2398298059308, 493.97777100030584, 608.89344364736, 617.9382061793874, 640.4012248547623, 665.5938781305642, 8195.34437245019, 8302.584870756438, 8415.747527574182, 8452.535110568977, 8545.273651739548, 506.61750378464023, 607.3198018219622, 610.5817515002149, 638.4573112854036, 698.8951657251453, 3965.560145324208, 4052.452918855976, 4098.8360465581045, 4107.812624690783, 4189.539150693421, 51591.48408515942, 52935.470645293826, 53157.73421132947, 53417.46582534203, 53471.0, 49174.770630734514, 49196.26205606919, 49883.501164988615, 50074.24888626674, 50443.0, 44289.55710442919, 45178.54821451743, 45206.0, 45345.773271134094, 45445.772771136595, 7943.563104029334, 8014.83970320602, 8034.83930321402, 8041.075276343061, 8127.065387480279, 31158.532622011142, 32452.35095298128, 32930.67069329276, 32980.50529242111, 33117.66882331146, 39052.0, 39531.0, 41011.7949410251, 43692.126157476036, 44193.11613767771, 10671.413072281099, 10894.67315980522, 10978.560857565928, 11014.229003969645, 11671.824922625998, 11879.940600296943, 12027.338496382783, 12417.689557761129, 12502.499900003899, 12503.37483125822, 11194.727214888046, 11647.126465514952, 11800.0, 11829.17195796286, 12291.262524248574, 11410.201285909907, 11741.589044383405, 11810.291382517076, 12135.271883687006, 12175.695607609881, 11112.388818615054, 11177.832332514856, 11264.718382040515, 11479.8278025828, 11547.653570392902, 9286.34995550332, 9451.196648284973, 9455.338126331366, 9461.763455913657, 9907.554160062671, 8746.65013399457, 9448.669296574586, 9449.14957653787, 9548.761280968032, 10052.597896084075], "unit": "score", "name": "yui.html", "value": 6237.409562778129}], "name": "dromaeo_css", "value": 7008.212242110859}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 110.0, 112.0, 123.0, 111.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 151.0, 158.0, 123.0, 150.0, 151.0, 125.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 165.0, 160.0, 162.0, 162.0, 163.0, 165.0, 172.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 73.0, 73.0, 73.0, 137.0, 71.0, 73.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 138.0, 95.0, 96.0, 95.0, 137.0, 95.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 113.0, 109.0, 111.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 58.0, 59.0, 61.0, 62.0, 60.0, 59.0, 66.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0, 74.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 90.0, 82.0, 83.0, 89.0, 82.0, 82.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [116.0, 121.0, 122.0, 118.0, 119.0, 115.0, 111.0, 126.0, 136.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [133.0, 144.0, 138.0, 146.0, 149.0, 132.0, 146.0, 145.0, 145.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 70.0, 66.0, 65.0, 66.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1502.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Earley", "value": 951.7091640000002}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [41714.28571428572], "unit": "score", "name": "RegExp", "value": 21.83868150684931}, {"lowerIsBetter": false, "replicates": [570.1254275940707], "unit": "score", "name": "Splay", "value": 142.93521400000006}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20528.28504517306}]} 05:19:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20528.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1502.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7008.21"}}} 05:19:29 INFO - Return code: 0 05:19:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:19:29 INFO - # TBPL SUCCESS # 05:19:29 INFO - Running post-action listener: _resource_record_post_action 05:19:29 INFO - Running post-run listener: _resource_record_post_run 05:19:30 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 28672; Write bytes: 568995840; Read time: 208; Write time: 465064 05:19:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 8192; Write bytes: 253796352; Read time: 100; Write time: 272892 05:19:30 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 314957824; Read time: 108; Write time: 192144 05:19:30 INFO - Running post-run listener: _upload_blobber_files 05:19:30 INFO - Blob upload gear active. 05:19:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:19:30 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 05:19:30 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'] 05:19:30 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 05:19:31 INFO - (blobuploader) - INFO - Open directory for files ... 05:19:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:19:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:32 INFO - (blobuploader) - INFO - Done attempting. 05:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:19:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:33 INFO - (blobuploader) - INFO - Done attempting. 05:19:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:19:33 INFO - Return code: 0 05:19:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:19:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:19:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd1d7c69747a9e7954f1d2bfa9be18904ba978ba69e87b74003b817a917fd19a1178c2f86fc4b1ac9caf1de264cc9bce69915770b60971e2604cb38e17eec9f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32d7405c19acc8ed49c504018c104f4d7c749d2eb00ae59f31855687733c55915085653358e9b9e3ee010d1746e4773315ebe30cddc602824f22e0e2e2f29cb5"} 05:19:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:19:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:19:33 INFO - Contents: 05:19:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd1d7c69747a9e7954f1d2bfa9be18904ba978ba69e87b74003b817a917fd19a1178c2f86fc4b1ac9caf1de264cc9bce69915770b60971e2604cb38e17eec9f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32d7405c19acc8ed49c504018c104f4d7c749d2eb00ae59f31855687733c55915085653358e9b9e3ee010d1746e4773315ebe30cddc602824f22e0e2e2f29cb5"} 05:19:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:19:33 INFO - Copying logs to upload dir... 05:19:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:19:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.057966 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-19 05:19:33.097512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 05:19:33.100871) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 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/cd1d7c69747a9e7954f1d2bfa9be18904ba978ba69e87b74003b817a917fd19a1178c2f86fc4b1ac9caf1de264cc9bce69915770b60971e2604cb38e17eec9f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32d7405c19acc8ed49c504018c104f4d7c749d2eb00ae59f31855687733c55915085653358e9b9e3ee010d1746e4773315ebe30cddc602824f22e0e2e2f29cb5"} build_url:https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/YrNHram-Rx6-xh3lyzLGxg/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/cd1d7c69747a9e7954f1d2bfa9be18904ba978ba69e87b74003b817a917fd19a1178c2f86fc4b1ac9caf1de264cc9bce69915770b60971e2604cb38e17eec9f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32d7405c19acc8ed49c504018c104f4d7c749d2eb00ae59f31855687733c55915085653358e9b9e3ee010d1746e4773315ebe30cddc602824f22e0e2e2f29cb5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 05:19:33.125871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 05:19:33.126237) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453207829.274664-1816256420 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-19 05:19:33.208524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 05:19:33.208875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 05:19:33.209251) ========= ========= Total master_lag: 0.30 =========