builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1452786895.02 results: success (0) buildid: 20160114053010 builduid: fbb7537f92ab4790864e716b73633173 revision: a2997ea0c867abb7d53254e0125fdd452a91022f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.018041) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.018521) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.018824) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004449 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.035982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.036291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.298987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.299414) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.349075) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.349376) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.349730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.350023) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 07:54:55-- 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% 29.2M=0s 2016-01-14 07:54:55 (29.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.518644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.518984) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015490 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.568989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:55.569386) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a2997ea0c867abb7d53254e0125fdd452a91022f --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 a2997ea0c867abb7d53254e0125fdd452a91022f --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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 07:54:55,798 truncating revision to first 12 chars 2016-01-14 07:54:55,799 Setting DEBUG logging. 2016-01-14 07:54:55,799 attempt 1/10 2016-01-14 07:54:55,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a2997ea0c867?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 07:54:56,038 unpacking tar archive at: fx-team-a2997ea0c867/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:56.100307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:56.100617) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:56.107797) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:56.108080) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 07:54:56.108468) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-14 07:54:56.108749) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:54:56 INFO - MultiFileLogger online at 20160114 07:54:56 in /builds/slave/test-pgo 07:54:56 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 07:54:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:54:56 INFO - {'append_to_log': False, 07:54:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:54:56 INFO - 'blob_upload_branch': 'Fx-Team', 07:54:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:54:56 INFO - 'branch': 'Fx-Team', 07:54:56 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:56 INFO - 'config_files': ('talos/linux_config.py',), 07:54:56 INFO - 'default_actions': ('clobber', 07:54:56 INFO - 'read-buildbot-config', 07:54:56 INFO - 'download-and-extract', 07:54:56 INFO - 'populate-webroot', 07:54:56 INFO - 'create-virtualenv', 07:54:56 INFO - 'install', 07:54:56 INFO - 'run-tests'), 07:54:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:56 INFO - 'download_minidump_stackwalk': True, 07:54:56 INFO - 'download_symbols': 'ondemand', 07:54:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:56 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:56 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:56 INFO - 'installer_path': 'installer.exe', 07:54:56 INFO - 'log_level': 'info', 07:54:56 INFO - 'log_name': 'talos', 07:54:56 INFO - 'log_to_console': True, 07:54:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:54:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:54:56 INFO - 'opt_config_files': (), 07:54:56 INFO - 'pip_index': False, 07:54:56 INFO - 'sps_profile': False, 07:54:56 INFO - 'sps_profile_interval': 0, 07:54:56 INFO - 'suite': 'dromaeojs-e10s', 07:54:56 INFO - 'system_bits': '32', 07:54:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:56 INFO - 'title': 'talos-linux64-ix-042', 07:54:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:56 INFO - 'use_talos_json': True, 07:54:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:54:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:56 INFO - 'work_dir': 'build'} 07:54:56 INFO - ##### 07:54:56 INFO - ##### Running clobber step. 07:54:56 INFO - ##### 07:54:56 INFO - Running pre-action listener: _resource_record_pre_action 07:54:56 INFO - Running main action method: clobber 07:54:56 INFO - rmtree: /builds/slave/test-pgo/build 07:54:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:54:56 INFO - Running post-action listener: _resource_record_post_action 07:54:56 INFO - ##### 07:54:56 INFO - ##### Running read-buildbot-config step. 07:54:56 INFO - ##### 07:54:56 INFO - Running pre-action listener: _resource_record_pre_action 07:54:56 INFO - Running main action method: read_buildbot_config 07:54:56 INFO - Using buildbot properties: 07:54:56 INFO - { 07:54:56 INFO - "project": "", 07:54:56 INFO - "product": "firefox", 07:54:56 INFO - "script_repo_revision": "production", 07:54:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:54:56 INFO - "repository": "", 07:54:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:54:56 INFO - "buildid": "20160114053010", 07:54:56 INFO - "pgo_build": "True", 07:54:56 INFO - "basedir": "/builds/slave/test-pgo", 07:54:56 INFO - "buildnumber": 448, 07:54:56 INFO - "slavename": "talos-linux64-ix-042", 07:54:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:54:56 INFO - "platform": "ubuntu64_hw", 07:54:56 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:54:56 INFO - "branch": "fx-team", 07:54:56 INFO - "repo_path": "integration/fx-team", 07:54:56 INFO - "revision": "a2997ea0c867abb7d53254e0125fdd452a91022f", 07:54:56 INFO - "stage_platform": "linux64-pgo", 07:54:56 INFO - "builduid": "fbb7537f92ab4790864e716b73633173", 07:54:56 INFO - "slavebuilddir": "test" 07:54:56 INFO - } 07:54:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:54:56 INFO - Running post-action listener: _resource_record_post_action 07:54:56 INFO - ##### 07:54:56 INFO - ##### Running download-and-extract step. 07:54:56 INFO - ##### 07:54:56 INFO - Running pre-action listener: _resource_record_pre_action 07:54:56 INFO - Running main action method: download_and_extract 07:54:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:54:56 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')]} 07:54:56 INFO - https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:54:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/test_packages.json 07:54:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/test_packages.json 07:54:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:54:57 INFO - Downloaded 1448 bytes. 07:54:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:54:57 INFO - Using the following test package requirements: 07:54:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:54:57 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:54:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'jsshell-linux-x86_64.zip'], 07:54:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:54:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:54:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:54:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:54:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:54:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:54: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')]} 07:54:57 INFO - https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:54:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:55:00 INFO - Downloaded 24030719 bytes. 07:55:00 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'] 07:55:00 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 07:55:01 INFO - Return code: 0 07:55:01 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 07:55:01 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')]} 07:55:01 INFO - https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:55:03 INFO - Downloaded 24030719 bytes. 07:55:03 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'] 07:55:03 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 07:55:05 INFO - Return code: 0 07:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:05 INFO - https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:55:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:55:07 INFO - Downloaded 11132144 bytes. 07:55:07 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'] 07:55:07 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 07:55:07 INFO - Return code: 0 07:55:07 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')]} 07:55:07 INFO - https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:55:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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 07:55:10 INFO - Downloaded 55861578 bytes. 07:55:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:10 INFO - mkdir: /builds/slave/test-pgo/properties 07:55:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:55:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:55:10 INFO - Contents: 07:55:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:10 INFO - Running post-action listener: _resource_record_post_action 07:55:10 INFO - Running post-action listener: set_extra_try_arguments 07:55:10 INFO - ##### 07:55:10 INFO - ##### Running populate-webroot step. 07:55:10 INFO - ##### 07:55:10 INFO - Running pre-action listener: _resource_record_pre_action 07:55:10 INFO - Running main action method: populate_webroot 07:55:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:55:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:55:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:55:10 INFO - '--tppagecycles', 07:55:10 INFO - '7'], 07:55:10 INFO - 'tests': ['tsvgm']}}, 07:55:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:55:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:55:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:55:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:55:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'tests': ['damp', 'tps']}, 07:55:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['damp', 'tps']}, 07:55:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:55:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:55:10 INFO - 'other': {'tests': ['a11yr', 07:55:10 INFO - 'ts_paint', 07:55:10 INFO - 'tpaint', 07:55:10 INFO - 'sessionrestore', 07:55:10 INFO - 'sessionrestore_no_auto_restore']}, 07:55:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['a11yr', 07:55:10 INFO - 'ts_paint', 07:55:10 INFO - 'tpaint', 07:55:10 INFO - 'sessionrestore', 07:55:10 INFO - 'sessionrestore_no_auto_restore']}, 07:55:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['a11yr', 07:55:10 INFO - 'ts_paint', 07:55:10 INFO - 'tpaint', 07:55:10 INFO - 'sessionrestore', 07:55:10 INFO - 'sessionrestore_no_auto_restore']}, 07:55:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['a11yr', 07:55:10 INFO - 'ts_paint', 07:55:10 INFO - 'tpaint', 07:55:10 INFO - 'sessionrestore', 07:55:10 INFO - 'sessionrestore_no_auto_restore']}, 07:55:10 INFO - 'other_l64': {'tests': ['a11yr', 07:55:10 INFO - 'ts_paint', 07:55:10 INFO - 'tpaint', 07:55:10 INFO - 'sessionrestore', 07:55:10 INFO - 'sessionrestore_no_auto_restore']}, 07:55:10 INFO - 'other_nol64': {'tests': ['a11yr', 07:55:10 INFO - 'ts_paint', 07:55:10 INFO - 'tpaint', 07:55:10 INFO - 'sessionrestore', 07:55:10 INFO - 'sessionrestore_no_auto_restore']}, 07:55:10 INFO - 'svgr': {'tests': ['tsvgx', 07:55:10 INFO - 'tsvgr_opacity', 07:55:10 INFO - 'tart', 07:55:10 INFO - 'tscrollx', 07:55:10 INFO - 'cart']}, 07:55:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['tsvgx', 07:55:10 INFO - 'tsvgr_opacity', 07:55:10 INFO - 'tart', 07:55:10 INFO - 'tscrollx', 07:55:10 INFO - 'cart']}, 07:55:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'tests': ['tp5o']}, 07:55:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'talos_options': ['--e10s'], 07:55:10 INFO - 'tests': ['tp5o']}, 07:55:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'talos_options': ['--xperf_path', 07:55:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:10 INFO - 'tests': ['tp5n']}, 07:55:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:10 INFO - 'talos_options': ['--e10s', 07:55:10 INFO - '--xperf_path', 07:55:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:10 INFO - 'tests': ['tp5n']}}, 07:55:10 INFO - 'talos.zip': {'path': '', 07:55:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:55:10 INFO - Running post-action listener: _resource_record_post_action 07:55:10 INFO - ##### 07:55:10 INFO - ##### Running create-virtualenv step. 07:55:10 INFO - ##### 07:55:10 INFO - Running pre-action listener: _resource_record_pre_action 07:55:10 INFO - Running main action method: create_virtualenv 07:55:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:55:10 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 07:55:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:55:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:55:10 INFO - Using real prefix '/usr' 07:55:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:55:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:55:12 INFO - Installing pip.................done. 07:55:12 INFO - Return code: 0 07:55:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:55:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:55:12 INFO - Using env: {'DISPLAY': ':0', 07:55:12 INFO - 'HOME': '/home/cltbld', 07:55:12 INFO - 'LANG': 'en_US.UTF-8', 07:55:12 INFO - 'LANGUAGE': 'en_US:en', 07:55:12 INFO - 'LOGNAME': 'cltbld', 07:55:12 INFO - 'MAIL': '/var/mail/cltbld', 07:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:12 INFO - 'MOZ_NO_REMOTE': '1', 07:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:12 INFO - 'NO_EM_RESTART': '1', 07:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:12 INFO - 'SHELL': '/bin/bash', 07:55:12 INFO - 'SHLVL': '1', 07:55:12 INFO - 'TERM': 'linux', 07:55:12 INFO - 'TMOUT': '86400', 07:55:12 INFO - 'USER': 'cltbld', 07:55:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:12 INFO - '_': '/tools/buildbot/bin/python'} 07:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:13 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 07:55:13 INFO - Cleaning up... 07:55:13 INFO - Return code: 0 07:55:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:55:13 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')]} 07:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:13 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')]} 07:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:13 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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:13 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 07:55:13 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 07:55:13 INFO - Using env: {'DISPLAY': ':0', 07:55:13 INFO - 'HOME': '/home/cltbld', 07:55:13 INFO - 'LANG': 'en_US.UTF-8', 07:55:13 INFO - 'LANGUAGE': 'en_US:en', 07:55:13 INFO - 'LOGNAME': 'cltbld', 07:55:13 INFO - 'MAIL': '/var/mail/cltbld', 07:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:13 INFO - 'MOZ_NO_REMOTE': '1', 07:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:13 INFO - 'NO_EM_RESTART': '1', 07:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:13 INFO - 'SHELL': '/bin/bash', 07:55:13 INFO - 'SHLVL': '1', 07:55:13 INFO - 'TERM': 'linux', 07:55:13 INFO - 'TMOUT': '86400', 07:55:13 INFO - 'USER': 'cltbld', 07:55:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:13 INFO - '_': '/tools/buildbot/bin/python'} 07:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:13 INFO - Downloading/unpacking psutil>=0.7.1 07:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:55:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:55:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:15 INFO - Installing collected packages: psutil 07:55:15 INFO - Running setup.py install for psutil 07:55:15 INFO - building 'psutil._psutil_linux' extension 07:55:15 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 07:55:15 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 07:55:15 INFO - building 'psutil._psutil_posix' extension 07:55:15 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 07:55:15 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 07:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:15 INFO - Successfully installed psutil 07:55:15 INFO - Cleaning up... 07:55:15 INFO - Return code: 0 07:55:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:55:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:55:15 INFO - Using env: {'DISPLAY': ':0', 07:55:15 INFO - 'HOME': '/home/cltbld', 07:55:15 INFO - 'LANG': 'en_US.UTF-8', 07:55:15 INFO - 'LANGUAGE': 'en_US:en', 07:55:15 INFO - 'LOGNAME': 'cltbld', 07:55:15 INFO - 'MAIL': '/var/mail/cltbld', 07:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:15 INFO - 'MOZ_NO_REMOTE': '1', 07:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:15 INFO - 'NO_EM_RESTART': '1', 07:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:15 INFO - 'SHELL': '/bin/bash', 07:55:15 INFO - 'SHLVL': '1', 07:55:15 INFO - 'TERM': 'linux', 07:55:15 INFO - 'TMOUT': '86400', 07:55:15 INFO - 'USER': 'cltbld', 07:55:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:15 INFO - '_': '/tools/buildbot/bin/python'} 07:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:55:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:55:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:55:17 INFO - Installing collected packages: mozsystemmonitor 07:55:17 INFO - Running setup.py install for mozsystemmonitor 07:55:17 INFO - Successfully installed mozsystemmonitor 07:55:17 INFO - Cleaning up... 07:55:17 INFO - Return code: 0 07:55:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:17 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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:17 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 07:55:17 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 07:55:17 INFO - Using env: {'DISPLAY': ':0', 07:55:17 INFO - 'HOME': '/home/cltbld', 07:55:17 INFO - 'LANG': 'en_US.UTF-8', 07:55:17 INFO - 'LANGUAGE': 'en_US:en', 07:55:17 INFO - 'LOGNAME': 'cltbld', 07:55:17 INFO - 'MAIL': '/var/mail/cltbld', 07:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:17 INFO - 'MOZ_NO_REMOTE': '1', 07:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:17 INFO - 'NO_EM_RESTART': '1', 07:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:17 INFO - 'SHELL': '/bin/bash', 07:55:17 INFO - 'SHLVL': '1', 07:55:17 INFO - 'TERM': 'linux', 07:55:17 INFO - 'TMOUT': '86400', 07:55:17 INFO - 'USER': 'cltbld', 07:55:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:17 INFO - '_': '/tools/buildbot/bin/python'} 07:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:18 INFO - Downloading/unpacking blobuploader==1.2.4 07:55:18 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 07:55:18 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 07:55:18 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 07:55:18 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 07:55:18 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 07:55:18 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 07:55:19 INFO - Downloading blobuploader-1.2.4.tar.gz 07:55:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:55:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:55:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:55:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:55:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 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 07:55:20 INFO - Downloading docopt-0.6.1.tar.gz 07:55:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:55:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:20 INFO - Running setup.py install for blobuploader 07:55:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:55:20 INFO - Running setup.py install for requests 07:55:21 INFO - Running setup.py install for docopt 07:55:21 INFO - Successfully installed blobuploader requests docopt 07:55:21 INFO - Cleaning up... 07:55:21 INFO - Return code: 0 07:55:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:21 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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:21 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 07:55:21 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 07:55:21 INFO - Using env: {'DISPLAY': ':0', 07:55:21 INFO - 'HOME': '/home/cltbld', 07:55:21 INFO - 'LANG': 'en_US.UTF-8', 07:55:21 INFO - 'LANGUAGE': 'en_US:en', 07:55:21 INFO - 'LOGNAME': 'cltbld', 07:55:21 INFO - 'MAIL': '/var/mail/cltbld', 07:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:21 INFO - 'MOZ_NO_REMOTE': '1', 07:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:21 INFO - 'NO_EM_RESTART': '1', 07:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:21 INFO - 'SHELL': '/bin/bash', 07:55:21 INFO - 'SHLVL': '1', 07:55:21 INFO - 'TERM': 'linux', 07:55:21 INFO - 'TMOUT': '86400', 07:55:21 INFO - 'USER': 'cltbld', 07:55:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:21 INFO - '_': '/tools/buildbot/bin/python'} 07:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:21 INFO - Running setup.py (path:/tmp/pip-2DGl67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:21 INFO - Running setup.py (path:/tmp/pip-AgFMuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:21 INFO - Running setup.py (path:/tmp/pip-D8ufVk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:21 INFO - Running setup.py (path:/tmp/pip-AciH5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:21 INFO - Running setup.py (path:/tmp/pip-ylz9TN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:21 INFO - Running setup.py (path:/tmp/pip-1wUuMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:21 INFO - Running setup.py (path:/tmp/pip-j70YdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:22 INFO - Running setup.py (path:/tmp/pip-OZhlJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:22 INFO - Running setup.py (path:/tmp/pip-_C4i_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:22 INFO - Running setup.py (path:/tmp/pip-jc0oly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:22 INFO - Running setup.py (path:/tmp/pip-5LXH2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:22 INFO - Running setup.py (path:/tmp/pip-8NRlx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:22 INFO - Running setup.py (path:/tmp/pip-2HPef2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:22 INFO - Running setup.py (path:/tmp/pip-4Bde9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:22 INFO - Running setup.py (path:/tmp/pip-hmDWx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:22 INFO - Running setup.py (path:/tmp/pip-gh8umG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:22 INFO - Running setup.py (path:/tmp/pip-NtAs5R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:22 INFO - Running setup.py install for manifestparser 07:55:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:55:22 INFO - Running setup.py install for mozcrash 07:55:22 INFO - Running setup.py install for mozdebug 07:55:23 INFO - Running setup.py install for mozdevice 07:55:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Running setup.py install for mozfile 07:55:23 INFO - Running setup.py install for mozhttpd 07:55:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Running setup.py install for mozinfo 07:55:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Running setup.py install for mozInstall 07:55:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Running setup.py install for mozleak 07:55:23 INFO - Running setup.py install for mozlog 07:55:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Running setup.py install for moznetwork 07:55:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:55:23 INFO - Running setup.py install for mozprocess 07:55:23 INFO - Running setup.py install for mozprofile 07:55:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:55:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:55:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:55:24 INFO - Running setup.py install for mozrunner 07:55:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:55:24 INFO - Running setup.py install for mozscreenshot 07:55:24 INFO - Running setup.py install for moztest 07:55:24 INFO - Running setup.py install for mozversion 07:55:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:55:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:55:24 INFO - Cleaning up... 07:55:24 INFO - Return code: 0 07:55:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:24 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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:24 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 07:55:24 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 07:55:24 INFO - Using env: {'DISPLAY': ':0', 07:55:24 INFO - 'HOME': '/home/cltbld', 07:55:24 INFO - 'LANG': 'en_US.UTF-8', 07:55:24 INFO - 'LANGUAGE': 'en_US:en', 07:55:24 INFO - 'LOGNAME': 'cltbld', 07:55:24 INFO - 'MAIL': '/var/mail/cltbld', 07:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:24 INFO - 'MOZ_NO_REMOTE': '1', 07:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:24 INFO - 'NO_EM_RESTART': '1', 07:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:24 INFO - 'SHELL': '/bin/bash', 07:55:24 INFO - 'SHLVL': '1', 07:55:24 INFO - 'TERM': 'linux', 07:55:24 INFO - 'TMOUT': '86400', 07:55:24 INFO - 'USER': 'cltbld', 07:55:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:24 INFO - '_': '/tools/buildbot/bin/python'} 07:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:24 INFO - Running setup.py (path:/tmp/pip-2KWkD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:55:24 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)) 07:55:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:24 INFO - Running setup.py (path:/tmp/pip-hZMg40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:55:24 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)) 07:55:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:24 INFO - Running setup.py (path:/tmp/pip-ZAgGHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:55:24 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)) 07:55:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:24 INFO - Running setup.py (path:/tmp/pip-Mkwesb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:25 INFO - Running setup.py (path:/tmp/pip-gyTN6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:25 INFO - Running setup.py (path:/tmp/pip-LsXvsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:25 INFO - Running setup.py (path:/tmp/pip-CzPfTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:25 INFO - Running setup.py (path:/tmp/pip-nlvh3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:25 INFO - Running setup.py (path:/tmp/pip-f_8cJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:25 INFO - Running setup.py (path:/tmp/pip-SHw_4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:25 INFO - Running setup.py (path:/tmp/pip-LhjCj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:25 INFO - Running setup.py (path:/tmp/pip-TtM1M3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:25 INFO - Running setup.py (path:/tmp/pip-3z0bQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:25 INFO - Running setup.py (path:/tmp/pip-UeNPe1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:25 INFO - Running setup.py (path:/tmp/pip-eDH8XB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:25 INFO - Running setup.py (path:/tmp/pip-xrzTXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:55:25 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)) 07:55:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:25 INFO - Running setup.py (path:/tmp/pip-vgErzZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:55:25 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)) 07:55:25 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)) 07:55:25 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)) 07:55:25 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)) 07:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:55:25 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)) 07:55:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:27 INFO - Downloading blessings-1.5.1.tar.gz 07:55:27 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 07:55:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:27 INFO - Installing collected packages: blessings 07:55:27 INFO - Running setup.py install for blessings 07:55:27 INFO - Successfully installed blessings 07:55:27 INFO - Cleaning up... 07:55:27 INFO - Return code: 0 07:55:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:55:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:55:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:55:28 INFO - Reading from file tmpfile_stdout 07:55:28 INFO - Current package versions: 07:55:28 INFO - argparse == 1.2.1 07:55:28 INFO - blessings == 1.5.1 07:55:28 INFO - blobuploader == 1.2.4 07:55:28 INFO - docopt == 0.6.1 07:55:28 INFO - manifestparser == 1.1 07:55:28 INFO - mozInstall == 1.12 07:55:28 INFO - mozcrash == 0.16 07:55:28 INFO - mozdebug == 0.1 07:55:28 INFO - mozdevice == 0.48 07:55:28 INFO - mozfile == 1.2 07:55:28 INFO - mozhttpd == 0.7 07:55:28 INFO - mozinfo == 0.9 07:55:28 INFO - mozleak == 0.1 07:55:28 INFO - mozlog == 3.1 07:55:28 INFO - moznetwork == 0.27 07:55:28 INFO - mozprocess == 0.22 07:55:28 INFO - mozprofile == 0.28 07:55:28 INFO - mozrunner == 6.11 07:55:28 INFO - mozscreenshot == 0.1 07:55:28 INFO - mozsystemmonitor == 0.0 07:55:28 INFO - moztest == 0.7 07:55:28 INFO - mozversion == 1.4 07:55:28 INFO - psutil == 3.1.1 07:55:28 INFO - requests == 1.2.3 07:55:28 INFO - wsgiref == 0.1.2 07:55:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:55: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')]} 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:28 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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:28 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 07:55:28 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 07:55:28 INFO - Using env: {'DISPLAY': ':0', 07:55:28 INFO - 'HOME': '/home/cltbld', 07:55:28 INFO - 'LANG': 'en_US.UTF-8', 07:55:28 INFO - 'LANGUAGE': 'en_US:en', 07:55:28 INFO - 'LOGNAME': 'cltbld', 07:55:28 INFO - 'MAIL': '/var/mail/cltbld', 07:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:28 INFO - 'MOZ_NO_REMOTE': '1', 07:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:28 INFO - 'NO_EM_RESTART': '1', 07:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:28 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:28 INFO - 'SHELL': '/bin/bash', 07:55:28 INFO - 'SHLVL': '1', 07:55:28 INFO - 'TERM': 'linux', 07:55:28 INFO - 'TMOUT': '86400', 07:55:28 INFO - 'USER': 'cltbld', 07:55:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:28 INFO - '_': '/tools/buildbot/bin/python'} 07:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 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)) 07:55:28 INFO - Cleaning up... 07:55:28 INFO - Return code: 0 07:55:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:55: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')]} 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:28 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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:28 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 07:55:28 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 07:55:28 INFO - Using env: {'DISPLAY': ':0', 07:55:28 INFO - 'HOME': '/home/cltbld', 07:55:28 INFO - 'LANG': 'en_US.UTF-8', 07:55:28 INFO - 'LANGUAGE': 'en_US:en', 07:55:28 INFO - 'LOGNAME': 'cltbld', 07:55:28 INFO - 'MAIL': '/var/mail/cltbld', 07:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:28 INFO - 'MOZ_NO_REMOTE': '1', 07:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:28 INFO - 'NO_EM_RESTART': '1', 07:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:28 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:28 INFO - 'SHELL': '/bin/bash', 07:55:28 INFO - 'SHLVL': '1', 07:55:28 INFO - 'TERM': 'linux', 07:55:28 INFO - 'TMOUT': '86400', 07:55:28 INFO - 'USER': 'cltbld', 07:55:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:28 INFO - '_': '/tools/buildbot/bin/python'} 07:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:28 INFO - Downloading/unpacking jsonschema 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:30 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 07:55:30 INFO - Downloading/unpacking functools32 (from jsonschema) 07:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:30 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:55:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:30 INFO - warning: no files found matching '*.txt' 07:55:30 INFO - no previously-included directories found matching 'build' 07:55:30 INFO - no previously-included directories found matching 'dist' 07:55:30 INFO - no previously-included directories found matching '.git*' 07:55:30 INFO - Installing collected packages: jsonschema, functools32 07:55:30 INFO - Running setup.py install for functools32 07:55:30 INFO - warning: no files found matching '*.txt' 07:55:30 INFO - no previously-included directories found matching 'build' 07:55:30 INFO - no previously-included directories found matching 'dist' 07:55:30 INFO - no previously-included directories found matching '.git*' 07:55:30 INFO - Successfully installed jsonschema functools32 07:55:30 INFO - Cleaning up... 07:55:30 INFO - Return code: 0 07:55:30 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:55: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')]} 07:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:30 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 0x7fd636bbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', '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 07:55:30 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 07:55:30 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 07:55:30 INFO - Using env: {'DISPLAY': ':0', 07:55:30 INFO - 'HOME': '/home/cltbld', 07:55:30 INFO - 'LANG': 'en_US.UTF-8', 07:55:30 INFO - 'LANGUAGE': 'en_US:en', 07:55:30 INFO - 'LOGNAME': 'cltbld', 07:55:30 INFO - 'MAIL': '/var/mail/cltbld', 07:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:30 INFO - 'MOZ_NO_REMOTE': '1', 07:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:30 INFO - 'NO_EM_RESTART': '1', 07:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:30 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:30 INFO - 'SHELL': '/bin/bash', 07:55:30 INFO - 'SHLVL': '1', 07:55:30 INFO - 'TERM': 'linux', 07:55:30 INFO - 'TMOUT': '86400', 07:55:30 INFO - 'USER': 'cltbld', 07:55:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:30 INFO - '_': '/tools/buildbot/bin/python'} 07:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:30 INFO - Downloading/unpacking flake8 07:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:55:32 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 07:55:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:55:32 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 07:55:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:33 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 07:55:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:55:33 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 07:55:33 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 07:55:33 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 07:55:33 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 07:55:33 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 07:55:33 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 07:55:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:55:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:33 INFO - no previously-included directories found matching 'docs/_build' 07:55:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:55:33 INFO - Running setup.py install for pep8 07:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:33 INFO - no previously-included directories found matching 'docs/_build' 07:55:33 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:55:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:55:33 INFO - Cleaning up... 07:55:33 INFO - Return code: 0 07:55:33 INFO - Running post-action listener: _resource_record_post_action 07:55:33 INFO - Running post-action listener: _start_resource_monitoring 07:55:33 INFO - Starting resource monitoring. 07:55:33 INFO - ##### 07:55:33 INFO - ##### Running install step. 07:55:33 INFO - ##### 07:55:33 INFO - Running pre-action listener: _resource_record_pre_action 07:55:33 INFO - Running main action method: install 07:55:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:55:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:55:33 INFO - Reading from file tmpfile_stdout 07:55:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:55:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:55:33 INFO - Reading from file tmpfile_stdout 07:55:33 INFO - Output received: 07:55:33 INFO - Usage: mozinstall [options] installer 07:55:33 INFO - Options: 07:55:33 INFO - -h, --help show this help message and exit 07:55:33 INFO - -d DEST, --destination=DEST 07:55:33 INFO - Directory to install application into. [default: 07:55:33 INFO - "/builds/slave/test-pgo"] 07:55:33 INFO - --app=APP Application being installed. [default: firefox] 07:55:33 INFO - mkdir: /builds/slave/test-pgo/build/application 07:55:33 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'] 07:55:33 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 07:55:49 INFO - Reading from file tmpfile_stdout 07:55:49 INFO - Output received: 07:55:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:55:49 INFO - Running post-action listener: _resource_record_post_action 07:55:49 INFO - ##### 07:55:49 INFO - ##### Running run-tests step. 07:55:49 INFO - ##### 07:55:49 INFO - Running pre-action listener: _resource_record_pre_action 07:55:49 INFO - Running main action method: run_tests 07:55:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:55:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:55:49 INFO - Python 2.7.3 07:55:49 INFO - Return code: 0 07:55:49 INFO - grabbing minidump binary from tooltool 07:55:49 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')]} 07:55:49 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 0x20b0840>, '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 0x201d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:55:49 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 07:55:49 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 07:55:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:50 INFO - Return code: 0 07:55:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:55:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:55:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:55:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:55:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:55:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:55:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:55:50 INFO - Return code: 0 07:55:50 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/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 07:55:50 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/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 07:55:50 INFO - Using env: {'DISPLAY': ':0', 07:55:50 INFO - 'HOME': '/home/cltbld', 07:55:50 INFO - 'LANG': 'en_US.UTF-8', 07:55:50 INFO - 'LANGUAGE': 'en_US:en', 07:55:50 INFO - 'LOGNAME': 'cltbld', 07:55:50 INFO - 'MAIL': '/var/mail/cltbld', 07:55:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:55:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:50 INFO - 'MOZ_NO_REMOTE': '1', 07:55:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:50 INFO - 'NO_EM_RESTART': '1', 07:55:50 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:50 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:55:50 INFO - 'SHELL': '/bin/bash', 07:55:50 INFO - 'SHLVL': '1', 07:55:50 INFO - 'TERM': 'linux', 07:55:50 INFO - 'TMOUT': '86400', 07:55:50 INFO - 'USER': 'cltbld', 07:55:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806', 07:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:50 INFO - '_': '/tools/buildbot/bin/python'} 07:55:50 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/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 07:55:51 INFO - mozversion application_buildid: 20160114053010 07:55:51 INFO - mozversion application_changeset: a2997ea0c867abb7d53254e0125fdd452a91022f 07:55:51 INFO - mozversion application_display_name: Nightly 07:55:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:51 INFO - mozversion application_name: Firefox 07:55:51 INFO - mozversion application_remotingname: firefox 07:55:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:55:51 INFO - mozversion application_vendor: Mozilla 07:55:51 INFO - mozversion application_version: 46.0a1 07:55:51 INFO - mozversion platform_buildid: 20160114053010 07:55:51 INFO - mozversion platform_changeset: a2997ea0c867abb7d53254e0125fdd452a91022f 07:55:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:55:51 INFO - mozversion platform_version: 46.0a1 07:55:51 INFO - using testdate: 1452786951 07:55:51 INFO - actual date: 1452786951 07:55:51 INFO - starting webserver on 'localhost:55860' 07:55:51 INFO - SUITE-START | Running 3 tests 07:55:51 INFO - TEST-START | dromaeo_css 07:55:51 INFO - operating with platform_type : linux_ 07:55:51 INFO - Initialising browser for dromaeo_css test... 07:55:51 INFO - TEST-INFO | started process 343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdzE4TU/profile http://localhost:55860/getInfo.html) 07:55:54 INFO - PROCESS | 343 | 07:55:54 INFO - PROCESS | 343 | (process:430): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:55:55 INFO - PROCESS | 343 | __metrics Screen width/height:1600/1200 07:55:55 INFO - PROCESS | 343 | colorDepth:24 07:55:55 INFO - PROCESS | 343 | Browser inner width/height: 1024/697 07:55:55 INFO - PROCESS | 343 | __metrics 07:55:55 INFO - PROCESS | 343 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:55:56 INFO - TEST-INFO | 343: exit 0 07:55:56 INFO - Browser initialized. 07:55:56 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:56 INFO - TEST-INFO | started process 479 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdzE4TU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:58 INFO - PROCESS | 479 | 07:55:58 INFO - PROCESS | 479 | (process:538): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:56:08 INFO - PROCESS | 479 | RSS: Main: 150618112 07:56:08 INFO - PROCESS | 479 | 07:56:58 INFO - PROCESS | 479 | 1452787018391 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] 07:59:06 INFO - PROCESS | 479 | Cycle 1(1): loaded http://localhost:55860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55860/tests/dromaeo/cssquery-ext.html) 07:59:07 INFO - PROCESS | 479 | RSS: Main: 155594752 07:59:07 INFO - PROCESS | 479 | 08:02:09 INFO - PROCESS | 479 | Cycle 1(1): loaded http://localhost:55860/tests/dromaeo/cssquery-ext.html (next: http://localhost:55860/tests/dromaeo/cssquery-jquery.html) 08:02:10 INFO - PROCESS | 479 | RSS: Main: 152375296 08:02:10 INFO - PROCESS | 479 | 08:05:11 INFO - PROCESS | 479 | Cycle 1(1): loaded http://localhost:55860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55860/tests/dromaeo/cssquery-mootools.html) 08:05:12 INFO - PROCESS | 479 | RSS: Main: 151650304 08:05:12 INFO - PROCESS | 479 | 08:08:14 INFO - PROCESS | 479 | Cycle 1(1): loaded http://localhost:55860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55860/tests/dromaeo/cssquery-prototype.html) 08:08:14 INFO - PROCESS | 479 | RSS: Main: 150151168 08:08:14 INFO - PROCESS | 479 | 08:11:17 INFO - PROCESS | 479 | Cycle 1(1): loaded http://localhost:55860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55860/tests/dromaeo/cssquery-yui.html) 08:11:17 INFO - PROCESS | 479 | RSS: Main: 151101440 08:11:17 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | Cycle 1(1): loaded http://localhost:55860/tests/dromaeo/cssquery-yui.html (next: http://localhost:55860/tests/dromaeo/cssquery-dojo.html) 08:14:20 INFO - PROCESS | 479 | RSS: Main: 153165824 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | __start_tp_report 08:14:20 INFO - PROCESS | 479 | _x_x_mozilla_page_load 08:14:20 INFO - PROCESS | 479 | _x_x_mozilla_page_load_details 08:14:20 INFO - PROCESS | 479 | |i|pagename|runs| 08:14:20 INFO - PROCESS | 479 | |0;dojo.html;3117.7817552771303;3138.325260069085;3169.429502689515;3175.5363139067967;3187.0279564732746;4815.711057336563;5036.3200967869325;5066.746662666866;5073.467285934979;5093.898122037557;4876.463589005207;4985.127602669537;5025.3718285214345;5043.420006699231;5055.898882022358;4575.428071491064;4642.512536183686;4660.836870709526;4714.811407543694;4732.597729193023;4493.910121797562;4588.24293991491;4611.792469338871;4625.838095666652;4661.137689527448;4500.234960056799;4514.841980530666;4580.450345958473;4612.7001744886475;4612.930806037912;4525.275955847049;4530.22986092365;4541.704789188692;4547.8635640930825;4613.700109492872;4414.3157810539415;4488.618467430272;4561.954380456186;4564.338170965225;4567.954320456786;4817.542333478314;4832.710037397767;4845.055214233226;4866.562009419169;4911.729854857981;5292.550133238679;5337.439568845254;5357.571394288448;5381.139017757179;5435.945640543583;5269.420363760021;5298.205269209611;5339.946600533984;5413.160960051198;5420.051490989061;5038.7984480620735;5063.544281014726;5075.619328550337;5102.209157580581;5113.897722045575;5457.754401051962;5474.781008759605;5475.425080366584;5490.505854473116;5504.53211477029;5141.38303403594;5215.608829337815;5297.470252974672;5321.6540924839765;5342.1452567589;5390.838274851761;5396.028714831289;5396.568274538027;5411;5424.538914192259;5332.493413125747;5361.892762144813;5385.7576409061685;5389.218563308298;5438.021156191844;5263.34208223972;5330.360356757214;5367.275417818544;5374.247605335257;5432.049391356497;4191.895202619898;4207.894802629959;4224.78876056196;4239.9788001060415;4250.298700714409;3803.82882770276;3825.9669889130337;3827.5215598050245;3832.0419895026243;3848.7113466490127;4963.726995015237;4988.102141614544;5006.374203224597;5026.54761071498;5028.220625803006;5383.896301258233;5385.353757549119;5409.350877894678;5415.1335786274;5445.809396671098;4955.231939049453;5026;5030.446650868402;5031.798728050837;5079.263506791494;4536.319552067151;4541.704789188692;4583.564561366665;4590.081983603292;4602.447706275201;5525.281713377235;5527.751251193706;5529.972350138223;5531.529819965348;5564.527015203672;5345.278387417727;5354.197714853452;5365.651232669864;5370.650907690988;5416.647917885325;5369.57043436532;5465.6447330923365;5480.26016487785;5515.145152501369;5553.611247212656;5333.040052790535;5338.519533242027;5345.518903298722;5348.171033489815;5367.973160134175;5390.218418329242;5413.079776438094;5424.566034717134;5443.074677304789;5479.671219726829;5113.718745469035;5176.637635365639;5258.0009798138235;5289.100852855101;5348.358197016383;5246.97376513115;5263.421023687315;5275.366955965309;5285.048691235615;5291.470852914677;5036.169032109661;5153.742312884416;5200.297959775533;5201.401838788436;5221.660592061504;5157.638965272395;5249.107651699144;5320.06898792702;5323.1216849219445;5370.140777475585;5162.586993040472;5186.09243382399;5193.506616871391;5210.609204309616;5216.895662086813 08:14:20 INFO - PROCESS | 479 | |1;ext.html;515.6081378152603;546.5982502860397;547.5099785691808;571.8570357410647;578.5458415144111;34225;34679.30641387171;34681.826590867044;34801.47797783029;34824.303513929706;35124;35502.64497355032;35598.82200588993;35727.4640880387;35747.106322341955;8219.260266576008;8430.662773489054;8431.3254939605;8435.451695639795;8435.83128337433;8247.628856701433;8334.749957501284;8339.874901876477;8340.87488687667;8380.83238335233;8273.958630206871;8397.748067557983;8410.831783364329;8449.662013519483;8455.112213217615;8232.83534329313;8341.45780524264;8344.916550834536;8388.8741668875;8401.201885820838;8138.470999385021;8268;8272.710455134042;8272.8345433091;8312.085670576233;34281.14297142567;34516;34639.30721385558;34753.82623086894;34792.13019674503;3176.0948129783133;3302.554155189067;3357.5467311912826;3376.9831150844334;3383.340248651514;28402.28994275139;28668.13995580115;28725;28880.71119288801;29047;3209.2297848516423;3230.2893363460003;3304.3886880927107;3364.66353364664;3422.0760394693293;267155;267452;268582;268942;269121;50597.24104138441;51862.74068629708;51907.48092519026;51921.48078519166;51985;46948.5305146951;62752.37247627557;63133;63303;63520.68239658864;15259.237038148049;15495.14776687293;15637.843621563867;15661.921690391475;15662.530124096294;12133.69665758363;12209.877901221053;12245.204061735958;12321.322327272086;12365.814512782135;18608.906955465405;18718.344857929907;18721.344752933583;18732.344367947328;19444.319448819224;7823.100343460575;7966.721164759206;7995.560244186626;8018.358531317481;8109.310708589718;907.382979573883;931.2643012020428;982.1013772398176;1001.9699409017741;1045.2630895218851;27191.456170876867;27576.586351204747;27793;27899.721002790116;27974.160775176777;1077.9676609701721;1108.4568561405015;1109.872364678056;1130.63819577736;1142.526718774915;14236.715265694835;14507.419703211754;14629.487967921072;14645.926770366294;14661.34023968924;310526;312999;313708;315072;315086;47990;48000;48107;48153.51846481561;48355.5164448351;1293.4438191577713;1321.3525372567565;1325.8342707161605;1352.5063351876495;1364.126958746403;26774.732252677222;26945.730542695106;30327.24181895382;30833.633057586627;31312.217194569406;43971.56028439675;44139.55860441483;44389.11221775611;44571.55428445674;44666.776666116464;287425;289175;289671;290836;291522;35405.46891796677;36777.63222367742;39942.600573993885;42234.15531689287;42259;38579;39232.607673922896;39370.40944385779;39677;39816.60183398129;33462.16344591307;33476.330473389906;34010.82994585011;34183.487247690806;34589.82705086459;33240.33598400648;35458.46812297766;35775.64224357723;36229.275414491036;36361.09097272589;34415.483767743004;34977.825110874284;35006.82496587501;35178.64821351856;35238.11904702403;30348.393032138792;31136.68863311338;32657.510137347483;32781.360931953786;32800.50799238061;24449.620855429308;24670.383240419134;24804.37989050288;25036.123735669164;25157.622635660846 08:14:20 INFO - PROCESS | 479 | |2;jquery.html;346.93663920084936;348.0359404449674;351.29915817943197;351.546505008539;355.7100962715388;15151.39394424223;15552.222388880553;16463.67072658546;16661.33354665812;17295.654086918286;11049.944750276258;11187;16643;16680;16714.749278760828;4551.340055691914;4872.610191184696;4897.289892965536;4906.877328066809;4927.556519913207;4796.112719146969;4889.926651100236;4891.828785992491;4894.339264199323;4929.65492415531;5118.539331460168;5254.763535640886;5267.051930652481;5308.336457942757;5318.627696061278;5189.792408303663;5215.765290561915;5224.45143259958;5254.21186821976;5410.5401040911565;5220.216967454912;5247.9737601311745;5259.86850328741;5270.604704647167;5271.051210782058;12840.743185136245;18842.90578547112;19439.3196238131;19448.22207111714;19548.31580894676;1999.2402886902885;2026.6554685703466;2065.2255404223415;2214.324630987548;2270.194081101218;9108.316876234308;9343.2525397968;11937.582184623583;12461.1900226485;12691.682707932283;1740.1386313774763;1812.9365472208542;1817.919778947314;1847.344192811546;1850.2044121027952;53586;55043.449565504234;55198;56076.719616402064;57007.14489282664;9723.854142187873;9900.108990190773;9902.306838521234;10026.398416095057;10087.798244035079;12858.357082145856;12953.352332383532;13001.219926804422;13017.804732929013;13046.54337098197;7563.243675632392;7594.696212151563;7625.313721765067;7630.160682324939;7636.08366995964;7408.592527411044;7460.888086678704;7486.064241969754;7531.661075251627;7554.811129721801;3871.5160604924386;3920.0395903003946;4331.285337919208;4373.387725718402;4391.604755572014;1807.5932915094;1881.491997160759;1884.679604467244;3012.472817256971;3020.3539071206246;879.2131042716733;904.8145130248283;985.4875464758286;1047.1308813684623;1049.0558497352292;15162.393504259706;16088.356465741474;16197.479929188205;16278.43025494102;16501.09243991568;928.4058202750246;945.394947233771;950.4582388038751;969.2488321550854;970.5001924009141;9043.231325337289;9259.675911343205;9569.61721531145;9585.664501742545;9598.088181622734;391548;393769;398705;553056.2347188238;556957;67572;71521;71711.2828871715;73452.63273683704;74925.99999999891;1126.380490730095;1142.0977427832086;1166.4284500594647;1194.462491878658;1208.6796998795326;14491.637709056937;14533.563993080224;14793.038452500983;14847;15037.548873533811;32264;32725.836370817993;33487.33025339528;33776;34149;39517;39771;40507.39238911478;40889.795551022056;42571.57428425676;7221.458390620619;7430.591317477591;7446.292602202782;7458.403327733659;7482.96258518704;9044.954775226082;10610.734731631772;11249.437528123397;11472.369019703663;11625.24435911663;8550.91449085526;9333.906660933304;9474.810503790024;9714.659986900424;9946.154576861049;9770.31607787448;9926.106650401498;10111.443870587189;10159.847602285823;10332.276740628384;10156.18750499973;10337.9483102584;10362.533685983997;10449.529771160163;10527.368357898551;6354.23749150105;6619.470442364695;6700;6736.326367363225;6871.793846184622;7840.607969601611;8484.618192181244;8521.105283945344;8659.52372619512;9073.90926090757 08:14:20 INFO - PROCESS | 479 | |3;mootools.html;1405.276282714402;1440.8126943497348;1563.6638122803595;1728.4814555633307;1755.7805274340699;6897.379235868771;6918.377346038856;6983.72065117396;7071.823204419892;7083.9645801770985;7187.28127187281;7218.4225261979045;7255.310745479171;7294.70821167154;7295.525790823606;2187.562487502498;2191.747948985867;2205.1730601024615;2212.524307273936;2216.9778302217014;2186.289455926822;2197.791209835071;2255.8759268240324;2277.20297895736;2277.840551161419;1890.7731072271347;1927.7012063130167;2225.3657707553352;2227.187076716995;2233.3300009997015;2120.703101565782;2142.4965133193764;2167.2522979572022;2167.349795061491;2171.1966572368165;2092.9790702092937;2107.3993911735233;2185.945351366213;2191.5288213034114;2195.5718634866207;7030.683619237147;7051.89422158668;7055.2239253682055;7078.929210707878;7083.079199704057;4268.466441694788;4334.804933777988;4354.238008348558;4367.45406824147;4381.408509851161;2776.1810265971585;2805.7474827265646;2845.5447128459346;2873.7126287371307;2897.8116422432477;910.2490445382585;932.324065052838;938.2119020023214;956.383132879289;961.0485619236975;8960.283177345797;9091.909080909238;9113.179813816789;9125.680601178994;9132.767076444728;3693.464447655129;3792.905177370588;3833.15670552478;3913.3934240192248;3923.136909879822;7663.578503182267;7677.9232207677205;7704.422168337285;7724.575148366781;7732.845343093107;4366.126774645084;4371.846985355561;4373.562643735665;4374.147041326911;4382.474103107647;4079.184163167319;4079.918401631951;4080.673546116363;4123.0516981094515;4128.876133715993;3246.8214248216573;3310.519974603669;3323.6344002159744;3325.584301962255;3327.1016825457473;1040.9375437473775;1058.1270451877233;1060.1571750458404;1067.2475904487317;1072.0565902006185;938.0994245524373;938.643315540104;1002.283367392318;1241.1870225002458;1268.2517314784322;6449.871002579922;6502.122213501211;6555.180602424697;6567.638779867153;6623.834404139839;1078.2613909472036;1094.2121672395863;1098.9450527473755;1103.624767579027;1143.999000874235;5148.485151484896;5192.376914770176;5202.947970520247;5220.686758794409;5224.268602395668;7974.920250797418;8117.188281171835;8251.876221856677;8456.661733530713;8457.281131103926;8289.95855020721;8308.501489910625;8313.459625124347;8318.251357377743;8346.290565301895;6731.115287719446;6837.9658101710165;6879.89680154798;6882.8623427531165;6918.066061081689;6425.389587989133;6430.935690643221;6447.290798012309;6449;6455.806325810233;7490.250974902466;7622.9237707622215;7781.26078022587;7820.452568320163;7827.45207835446;7361.4110871129105;7449.888251676338;7489.8876516851205;7866.803329916798;7934.722284720238;6134.325224225421;6176.629402235881;6228.564000520101;6232.688365581612;6233.968830156002;6276.1213430118905;6436.613803171825;6456.289808121009;6459.903101453576;6627.635480048643;6363.809085727436;6447.9032814508755;6494.967525162344;6533.836654083686;6549.050387693663;6286.685665716787;6288.748450061947;6305.054241863757;6386.457151142205;6424.582402143846;6260.561760676709;6307.463865571294;6317.5893566918;6341.27075386318;6354;5822.359540450462;5865.824025279248;5893.2044174035955;5930.28836539618;5956.344802071855;5906.970465147647;5929.110633405024;5937.910931335947;5938.435848594377;5977.491913187428 08:14:20 INFO - PROCESS | 479 | |4;prototype.html;326.60317713977526;336.2400973799214;338.0837929211836;338.71717116207964;346.65161512679754;6255.7497700092;6283.717232724527;6311.779087731925;6333.873322533546;6404.391582799638;6253.593516421441;6276.246850377961;6280.277768056663;6285.9685701571425;6305.369463053692;4792.736399498026;4798.880027999293;4801.639877009238;4817.01251243496;4818.084563932859;4821.180399332105;4821.2768084787385;4822.710637361752;4823.855284341475;4833.32333473314;4672.97663511682;4765.166095933215;4767.332573439721;4772.856814295576;4777.5222477752295;4762.761861906891;4768.546988036148;4779.235322348408;4783.258594917776;4796.304535842318;4135.379693046037;4142.772147531885;4149.356849688304;4152.211079894811;4155.625993660585;6010.188624535675;6030.577859549833;6040.426159514839;6043.697815109271;6094.786682466092;5428;5515.669059856381;5532.253145825302;5532.533878522195;5549.6115271930985;6628.072069910217;6653.068570400148;6662.133922590081;6672.833179170511;6678.465722742218;4550.817967281338;4568.497465278817;4583.0604726031415;4587.72473651582;4590.036092420596;6756.155480564929;6839.179298484164;6915.723371065152;6918.481113916426;6921.411680007205;4627.490975992706;4638.721676699409;4645.953540464552;4646.697964632288;4668.393108895822;4699.177643912301;4705.270683044134;4707.270373092176;4709.387779588632;4718.669693121448;5493.313335833021;5494.2857428534035;5497.175423686479;5507.586930980193;5511;6472.05838248533;6658.500612454085;6675.732970681215;6676.766313179112;6695.12963314766;1599.8880078394634;1601.5595711179285;1630.853223209893;1631.111044480761;1647.3657641807752;1088.1947358954317;1109.8168802147716;1112.4548971004149;1112.5549780087867;1116.1851848150734;6138.815835524942;6211.2857021443115;6271.090691849748;6312.179416675803;6315.905261421082;6724.495662825308;6760.594364338155;6768.932310676831;6786.966065169642;6809.863802724017;6144.477719393813;6193;6247.500199983991;6250.718717657716;6276.874462510724;3694;3707.870224542128;3715.3126671565847;3722.7021838252876;3723.422869455239;7022.4733145014325;7061.152661680529;7082.964585177041;7083.574985500886;7095.219525852152;6774.661266936633;6917.9308206917285;6948.5483443576;6957.756478523227;6959.095317608679;6992.825179370455;7009.7897063088185;7011.193712723;7014.754483593049;7020.824479387954;6751.662416879235;6790.524663273523;6796.456283497408;6797.898031529432;6800.387965082969;6547.050677651619;6638;6679.365460281266;6681.966590167018;6683.064370987969;6994.195667498099;7048.577085374894;7059.647017649199;7064.788056358318;7075.752348667772;4563.498015218257;4573.839915602938;4573.931391029204;4574.931376029429;4579.954200458086;6786.728530858711;6788.49086318538;6788.96605516989;6798.320167983162;6956.2695916928;6724.596524208563;6737.3599508046655;6750.426213771884;6775;6777.08509351251;6705.430038446787;6726.764563240263;6728.360805723449;6730.899036514554;6737.59574425536;6460.353964603502;6507.967460162668;6532.444742196966;6585.176852893388;6597.241317248386;6749.966250168718;6754;6755.088063111417;6772.424343930821;6781.11845460087;6545.607263564011;6579.144711187515;6583.604983700993;6586.110875032001;6589.8797204474395 08:14:20 INFO - PROCESS | 479 | |5;yui.html;681.7852376501402;687.0415770000849;757.696921231507;778.5717855179649;784.7920301120204;13118.868811311884;13159.736805263889;13192.868071319284;13281.070325077248;13306.135101218426;12954.80567791484;13098.41057152428;13100.41048152833;13172.407241674124;13199.604011879635;782.7103971530541;790.4111436979458;791.4934441957153;794.6980147543954;808.5633757770797;813.2396209544065;815.4251252866744;816.7059858450982;820.5856042698429;821.843849668561;837.3552364679193;839.202757380491;839.9962045355802;845.3026253341018;846.1453931529138;827.4580150001728;836.7322456813761;839.920207580282;841.9896124650444;843.5992903370911;615.7783198048699;622.6202016769766;624.2820756130441;624.3475568031419;625.8904691678983;13316.067875248737;13473.124246923919;13544.45822167112;13589.864101358959;13650.726985460235;11266.605668801634;11294;11419.625362098377;11602.361870097142;11625.941870290679;10074.143697785697;10465.581376744922;10587.78824423515;10663.840042399293;10906.61826836057;3507.8070706111153;3565.964340356615;3577.910552236189;3581.4627805829073;3589.94615080774;46420.7678961603;46633.53366466292;46642.30036549454;46838.53161468376;47045;9400.576974036185;9627.5667594957;9646.710598682052;9801.362911410735;9936.900630993741;16845.747313790303;16915.23881425314;16931.661366772594;16935.66128677444;16977.236024378686;7092.148942126978;7278.381337586365;7308.086489188851;7360.07999000125;7491.587962662106;4033.092554175287;4052.1895620875944;4067.430559721641;4153.273177193979;4167.937480937789;2817.0985284708695;2838.4181242845166;2840.616516770251;2841.971580284212;2851.158908122109;518.2174915877052;539.719345940109;540.235566673161;545.9235707001023;546.8304825504027;540.6404740847292;571.4999375546397;637.5377851057946;643.0482885329739;696.7944456385378;7932.643031063616;8100.2304781045705;8930.910690893137;9205.171534561921;9257.166854982948;513.6661170239374;535.1063723581628;606.5283425846231;623.5261201486902;669.5480550628404;3834.5620392352866;3894.4937158169823;3945.2109578084496;3957;3973.8013099345494;50766.74616626893;51033.489665102876;51134.48865511372;51986.22020669693;52620.210696839575;46990.4271538901;47572.28641570379;47704.522954770706;48246;48681.26978095331;43161;43684.12631747347;43747.34378984254;44030.779846100566;44128.3380749289;7737.226277372218;7773.222677732181;7848.960755196187;7912.248336408032;7993.880091798744;32218.19454513656;32272;32794.18014549655;33120;33148.1712957178;39890;39936.80031599823;41305.380419293135;41779.164416712105;42404.1519169621;9880;9902.900970990198;9959.950200248952;10164.949175254373;10178.440185789852;11839.28964262147;12053.57812476559;12146.696332591757;12162.148649594443;12589.18170318963;9928.602855885973;10093.142082923034;10124.797504050026;11624.334084877937;11747.706307342043;10952.388045620932;11185.552577896793;11565.653030409101;11652;11690.941545292219;10199.224521771863;10491.160707143257;10567;10653.680389588324;10843.891561084289;8786.692465763668;9231.723048308562;9256.72229833106;9379.968203497474;9557.139857412867;8277.420580559303;8517.44636598619;8518.403711740119;8930.240929521064;9833.065858743408 08:14:20 INFO - PROCESS | 479 | __end_tp_report 08:14:20 INFO - PROCESS | 479 | __start_cc_report 08:14:20 INFO - PROCESS | 479 | _x_x_mozilla_cycle_collect,311 08:14:20 INFO - PROCESS | 479 | __end_cc_report 08:14:20 INFO - PROCESS | 479 | __startTimestamp1452788060432__endTimestamp 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | ------- Summary: start ------- 08:14:20 INFO - PROCESS | 479 | Number of tests: 6 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | [#0] dojo.html Cycles:165 Average:4998.82 Median:5186.09 stddev:522.06 (10.1%) stddev-sans-first:502.38 08:14:20 INFO - PROCESS | 479 | Values: 3117.8 3138.3 3169.4 3175.5 3187.0 4815.7 5036.3 5066.7 5073.5 5093.9 4876.5 4985.1 5025.4 5043.4 5055.9 4575.4 4642.5 4660.8 4714.8 4732.6 4493.9 4588.2 4611.8 4625.8 4661.1 4500.2 4514.8 4580.5 4612.7 4612.9 4525.3 4530.2 4541.7 4547.9 4613.7 4414.3 4488.6 4562.0 4564.3 4568.0 4817.5 4832.7 4845.1 4866.6 4911.7 5292.6 5337.4 5357.6 5381.1 5435.9 5269.4 5298.2 5339.9 5413.2 5420.1 5038.8 5063.5 5075.6 5102.2 5113.9 5457.8 5474.8 5475.4 5490.5 5504.5 5141.4 5215.6 5297.5 5321.7 5342.1 5390.8 5396.0 5396.6 5411.0 5424.5 5332.5 5361.9 5385.8 5389.2 5438.0 5263.3 5330.4 5367.3 5374.2 5432.0 4191.9 4207.9 4224.8 4240.0 4250.3 3803.8 3826.0 3827.5 3832.0 3848.7 4963.7 4988.1 5006.4 5026.5 5028.2 5383.9 5385.4 5409.4 5415.1 5445.8 4955.2 5026.0 5030.4 5031.8 5079.3 4536.3 4541.7 4583.6 4590.1 4602.4 5525.3 5527.8 5530.0 5531.5 5564.5 5345.3 5354.2 5365.7 5370.7 5416.6 5369.6 5465.6 5480.3 5515.1 5553.6 5333.0 5338.5 5345.5 5348.2 5368.0 5390.2 5413.1 5424.6 5443.1 5479.7 5113.7 5176.6 5258.0 5289.1 5348.4 5247.0 5263.4 5275.4 5285.0 5291.5 5036.2 5153.7 5200.3 5201.4 5221.7 5157.6 5249.1 5320.1 5323.1 5370.1 5162.6 5186.1 5193.5 5210.6 5216.9 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | [#1] ext.html Cycles:180 Average:45199.37 Median:34552.91 stddev:76056.61 (220.1%) stddev-sans-first:76195.97 08:14:20 INFO - PROCESS | 479 | Values: 515.6 546.6 547.5 571.9 578.5 34225.0 34679.3 34681.8 34801.5 34824.3 35124.0 35502.6 35598.8 35727.5 35747.1 8219.3 8430.7 8431.3 8435.5 8435.8 8247.6 8334.7 8339.9 8340.9 8380.8 8274.0 8397.7 8410.8 8449.7 8455.1 8232.8 8341.5 8344.9 8388.9 8401.2 8138.5 8268.0 8272.7 8272.8 8312.1 34281.1 34516.0 34639.3 34753.8 34792.1 3176.1 3302.6 3357.5 3377.0 3383.3 28402.3 28668.1 28725.0 28880.7 29047.0 3209.2 3230.3 3304.4 3364.7 3422.1 267155.0 267452.0 268582.0 268942.0 269121.0 50597.2 51862.7 51907.5 51921.5 51985.0 46948.5 62752.4 63133.0 63303.0 63520.7 15259.2 15495.1 15637.8 15661.9 15662.5 12133.7 12209.9 12245.2 12321.3 12365.8 18608.9 18718.3 18721.3 18732.3 19444.3 7823.1 7966.7 7995.6 8018.4 8109.3 907.4 931.3 982.1 1002.0 1045.3 27191.5 27576.6 27793.0 27899.7 27974.2 1078.0 1108.5 1109.9 1130.6 1142.5 14236.7 14507.4 14629.5 14645.9 14661.3 310526.0 312999.0 313708.0 315072.0 315086.0 47990.0 48000.0 48107.0 48153.5 48355.5 1293.4 1321.4 1325.8 1352.5 1364.1 26774.7 26945.7 30327.2 30833.6 31312.2 43971.6 44139.6 44389.1 44571.6 44666.8 287425.0 289175.0 289671.0 290836.0 291522.0 35405.5 36777.6 39942.6 42234.2 42259.0 38579.0 39232.6 39370.4 39677.0 39816.6 33462.2 33476.3 34010.8 34183.5 34589.8 33240.3 35458.5 35775.6 36229.3 36361.1 34415.5 34977.8 35006.8 35178.6 35238.1 30348.4 31136.7 32657.5 32781.4 32800.5 24449.6 24670.4 24804.4 25036.1 25157.6 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | [#2] jquery.html Cycles:180 Average:25014.73 Median:4382.50 stddev:76184.16 (1738.4%) stddev-sans-first:76375.36 08:14:20 INFO - PROCESS | 479 | Values: 346.9 348.0 351.3 351.5 355.7 15151.4 15552.2 16463.7 16661.3 17295.7 11049.9 11187.0 16643.0 16680.0 16714.7 4551.3 4872.6 4897.3 4906.9 4927.6 4796.1 4889.9 4891.8 4894.3 4929.7 5118.5 5254.8 5267.1 5308.3 5318.6 5189.8 5215.8 5224.5 5254.2 5410.5 5220.2 5248.0 5259.9 5270.6 5271.1 12840.7 18842.9 19439.3 19448.2 19548.3 1999.2 2026.7 2065.2 2214.3 2270.2 9108.3 9343.3 11937.6 12461.2 12691.7 1740.1 1812.9 1817.9 1847.3 1850.2 53586.0 55043.4 55198.0 56076.7 57007.1 9723.9 9900.1 9902.3 10026.4 10087.8 12858.4 12953.4 13001.2 13017.8 13046.5 7563.2 7594.7 7625.3 7630.2 7636.1 7408.6 7460.9 7486.1 7531.7 7554.8 3871.5 3920.0 4331.3 4373.4 4391.6 1807.6 1881.5 1884.7 3012.5 3020.4 879.2 904.8 985.5 1047.1 1049.1 15162.4 16088.4 16197.5 16278.4 16501.1 928.4 945.4 950.5 969.2 970.5 9043.2 9259.7 9569.6 9585.7 9598.1 391548.0 393769.0 398705.0 553056.2 556957.0 67572.0 71521.0 71711.3 73452.6 74926.0 1126.4 1142.1 1166.4 1194.5 1208.7 14491.6 14533.6 14793.0 14847.0 15037.5 32264.0 32725.8 33487.3 33776.0 34149.0 39517.0 39771.0 40507.4 40889.8 42571.6 7221.5 7430.6 7446.3 7458.4 7483.0 9045.0 10610.7 11249.4 11472.4 11625.2 8550.9 9333.9 9474.8 9714.7 9946.2 9770.3 9926.1 10111.4 10159.8 10332.3 10156.2 10337.9 10362.5 10449.5 10527.4 6354.2 6619.5 6700.0 6736.3 6871.8 7840.6 8484.6 8521.1 8659.5 9073.9 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | [#3] mootools.html Cycles:180 Average:4945.28 Median:6230.63 stddev:2461.23 (39.5%) stddev-sans-first:2453.75 08:14:20 INFO - PROCESS | 479 | Values: 1405.3 1440.8 1563.7 1728.5 1755.8 6897.4 6918.4 6983.7 7071.8 7084.0 7187.3 7218.4 7255.3 7294.7 7295.5 2187.6 2191.7 2205.2 2212.5 2217.0 2186.3 2197.8 2255.9 2277.2 2277.8 1890.8 1927.7 2225.4 2227.2 2233.3 2120.7 2142.5 2167.3 2167.3 2171.2 2093.0 2107.4 2185.9 2191.5 2195.6 7030.7 7051.9 7055.2 7078.9 7083.1 4268.5 4334.8 4354.2 4367.5 4381.4 2776.2 2805.7 2845.5 2873.7 2897.8 910.2 932.3 938.2 956.4 961.0 8960.3 9091.9 9113.2 9125.7 9132.8 3693.5 3792.9 3833.2 3913.4 3923.1 7663.6 7677.9 7704.4 7724.6 7732.8 4366.1 4371.8 4373.6 4374.1 4382.5 4079.2 4079.9 4080.7 4123.1 4128.9 3246.8 3310.5 3323.6 3325.6 3327.1 1040.9 1058.1 1060.2 1067.2 1072.1 938.1 938.6 1002.3 1241.2 1268.3 6449.9 6502.1 6555.2 6567.6 6623.8 1078.3 1094.2 1098.9 1103.6 1144.0 5148.5 5192.4 5202.9 5220.7 5224.3 7974.9 8117.2 8251.9 8456.7 8457.3 8290.0 8308.5 8313.5 8318.3 8346.3 6731.1 6838.0 6879.9 6882.9 6918.1 6425.4 6430.9 6447.3 6449.0 6455.8 7490.3 7622.9 7781.3 7820.5 7827.5 7361.4 7449.9 7489.9 7866.8 7934.7 6134.3 6176.6 6228.6 6232.7 6234.0 6276.1 6436.6 6456.3 6459.9 6627.6 6363.8 6447.9 6495.0 6533.8 6549.1 6286.7 6288.7 6305.1 6386.5 6424.6 6260.6 6307.5 6317.6 6341.3 6354.0 5822.4 5865.8 5893.2 5930.3 5956.3 5907.0 5929.1 5937.9 5938.4 5977.5 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | [#4] prototype.html Cycles:180 Average:5536.16 Median:6278.58 stddev:1676.60 (26.7%) stddev-sans-first:1635.07 08:14:20 INFO - PROCESS | 479 | Values: 326.6 336.2 338.1 338.7 346.7 6255.7 6283.7 6311.8 6333.9 6404.4 6253.6 6276.2 6280.3 6286.0 6305.4 4792.7 4798.9 4801.6 4817.0 4818.1 4821.2 4821.3 4822.7 4823.9 4833.3 4673.0 4765.2 4767.3 4772.9 4777.5 4762.8 4768.5 4779.2 4783.3 4796.3 4135.4 4142.8 4149.4 4152.2 4155.6 6010.2 6030.6 6040.4 6043.7 6094.8 5428.0 5515.7 5532.3 5532.5 5549.6 6628.1 6653.1 6662.1 6672.8 6678.5 4550.8 4568.5 4583.1 4587.7 4590.0 6756.2 6839.2 6915.7 6918.5 6921.4 4627.5 4638.7 4646.0 4646.7 4668.4 4699.2 4705.3 4707.3 4709.4 4718.7 5493.3 5494.3 5497.2 5507.6 5511.0 6472.1 6658.5 6675.7 6676.8 6695.1 1599.9 1601.6 1630.9 1631.1 1647.4 1088.2 1109.8 1112.5 1112.6 1116.2 6138.8 6211.3 6271.1 6312.2 6315.9 6724.5 6760.6 6768.9 6787.0 6809.9 6144.5 6193.0 6247.5 6250.7 6276.9 3694.0 3707.9 3715.3 3722.7 3723.4 7022.5 7061.2 7083.0 7083.6 7095.2 6774.7 6917.9 6948.5 6957.8 6959.1 6992.8 7009.8 7011.2 7014.8 7020.8 6751.7 6790.5 6796.5 6797.9 6800.4 6547.1 6638.0 6679.4 6682.0 6683.1 6994.2 7048.6 7059.6 7064.8 7075.8 4563.5 4573.8 4573.9 4574.9 4580.0 6786.7 6788.5 6789.0 6798.3 6956.3 6724.6 6737.4 6750.4 6775.0 6777.1 6705.4 6726.8 6728.4 6730.9 6737.6 6460.4 6508.0 6532.4 6585.2 6597.2 6750.0 6754.0 6755.1 6772.4 6781.1 6545.6 6579.1 6583.6 6586.1 6589.9 08:14:20 INFO - PROCESS | 479 | 08:14:20 INFO - PROCESS | 479 | [#5] yui.html Cycles:180 Average:13043.35 Median:47017.71 stddev:14798.41 (31.5%) stddev-sans-first:14810.80 08:14:20 INFO - PROCESS | 479 | Values: 681.8 687.0 757.7 778.6 784.8 13118.9 13159.7 13192.9 13281.1 13306.1 12954.8 13098.4 13100.4 13172.4 13199.6 782.7 790.4 791.5 794.7 808.6 813.2 815.4 816.7 820.6 821.8 837.4 839.2 840.0 845.3 846.1 827.5 836.7 839.9 842.0 843.6 615.8 622.6 624.3 624.3 625.9 13316.1 13473.1 13544.5 13589.9 13650.7 11266.6 11294.0 11419.6 11602.4 11625.9 10074.1 10465.6 10587.8 10663.8 10906.6 3507.8 3566.0 3577.9 3581.5 3589.9 46420.8 46633.5 46642.3 46838.5 47045.0 9400.6 9627.6 9646.7 9801.4 9936.9 16845.7 16915.2 16931.7 16935.7 16977.2 7092.1 7278.4 7308.1 7360.1 7491.6 4033.1 4052.2 4067.4 4153.3 4167.9 2817.1 2838.4 2840.6 2842.0 2851.2 518.2 539.7 540.2 545.9 546.8 540.6 571.5 637.5 643.0 696.8 7932.6 8100.2 8930.9 9205.2 9257.2 513.7 535.1 606.5 623.5 669.5 3834.6 3894.5 3945.2 3957.0 3973.8 50766.7 51033.5 51134.5 51986.2 52620.2 46990.4 47572.3 47704.5 48246.0 48681.3 43161.0 43684.1 43747.3 44030.8 44128.3 7737.2 7773.2 7849.0 7912.2 7993.9 32218.2 32272.0 32794.2 33120.0 33148.2 39890.0 39936.8 41305.4 41779.2 42404.2 9880.0 9902.9 9960.0 10164.9 10178.4 11839.3 12053.6 12146.7 12162.1 12589.2 9928.6 10093.1 10124.8 11624.3 11747.7 10952.4 11185.6 11565.7 11652.0 11690.9 10199.2 10491.2 10567.0 10653.7 10843.9 8786.7 9231.7 9256.7 9380.0 9557.1 8277.4 8517.4 8518.4 8930.2 9833.1 08:14:20 INFO - PROCESS | 479 | -------- Summary: end -------- 08:14:20 INFO - PROCESS | 479 | 08:14:21 INFO - TEST-INFO | 479: exit 0 08:14:21 INFO - TEST-OK | dromaeo_css | took 1109957ms 08:14:21 INFO - TEST-START | kraken 08:14:21 INFO - operating with platform_type : linux_ 08:14:21 INFO - Initialising browser for kraken test... 08:14:21 INFO - TEST-INFO | started process 718 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPQu7I3/profile http://localhost:55860/getInfo.html) 08:14:24 INFO - PROCESS | 718 | 08:14:24 INFO - PROCESS | 718 | (process:790): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:14:25 INFO - PROCESS | 718 | __metrics Screen width/height:1600/1200 08:14:25 INFO - PROCESS | 718 | colorDepth:24 08:14:25 INFO - PROCESS | 718 | Browser inner width/height: 1024/697 08:14:25 INFO - PROCESS | 718 | __metrics 08:14:25 INFO - PROCESS | 718 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:14:26 INFO - TEST-INFO | 718: exit 0 08:14:26 INFO - Browser initialized. 08:14:26 INFO - Running cycle 1/1 for kraken test... 08:14:26 INFO - TEST-INFO | started process 845 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPQu7I3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:27 INFO - PROCESS | 845 | 08:14:27 INFO - PROCESS | 845 | (process:904): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:14:38 INFO - PROCESS | 845 | RSS: Main: 150560768 08:14:38 INFO - PROCESS | 845 | 08:14:40 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55860/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:41 INFO - PROCESS | 845 | RSS: Main: 150622208 08:14:41 INFO - PROCESS | 845 | 08:14:44 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55860/tests/kraken/driver.html?testName=audio-dft) 08:14:44 INFO - PROCESS | 845 | RSS: Main: 154382336 08:14:44 INFO - PROCESS | 845 | 08:14:47 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55860/tests/kraken/driver.html?testName=audio-fft) 08:14:48 INFO - PROCESS | 845 | RSS: Main: 147046400 08:14:48 INFO - PROCESS | 845 | 08:14:50 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55860/tests/kraken/driver.html?testName=audio-oscillator) 08:14:51 INFO - PROCESS | 845 | RSS: Main: 148475904 08:14:51 INFO - PROCESS | 845 | 08:14:53 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:54 INFO - PROCESS | 845 | RSS: Main: 148074496 08:14:54 INFO - PROCESS | 845 | 08:14:57 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55860/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:57 INFO - PROCESS | 845 | RSS: Main: 149762048 08:14:57 INFO - PROCESS | 845 | 08:15:01 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55860/tests/kraken/driver.html?testName=imaging-desaturate) 08:15:01 INFO - PROCESS | 845 | RSS: Main: 149938176 08:15:01 INFO - PROCESS | 845 | 08:15:04 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55860/tests/kraken/driver.html?testName=json-parse-financial) 08:15:05 INFO - PROCESS | 845 | RSS: Main: 149684224 08:15:05 INFO - PROCESS | 845 | 08:15:06 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:15:07 INFO - PROCESS | 845 | RSS: Main: 149848064 08:15:07 INFO - PROCESS | 845 | 08:15:09 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:15:09 INFO - PROCESS | 845 | RSS: Main: 148860928 08:15:09 INFO - PROCESS | 845 | 08:15:11 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:15:12 INFO - PROCESS | 845 | RSS: Main: 149364736 08:15:12 INFO - PROCESS | 845 | 08:15:14 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:15 INFO - PROCESS | 845 | RSS: Main: 149413888 08:15:15 INFO - PROCESS | 845 | 08:15:17 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:18 INFO - PROCESS | 845 | RSS: Main: 150069248 08:15:18 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | Cycle 1(1): loaded http://localhost:55860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55860/tests/kraken/driver.html?testName=ai-astar) 08:15:20 INFO - PROCESS | 845 | RSS: Main: 149262336 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | __start_tp_report 08:15:20 INFO - PROCESS | 845 | _x_x_mozilla_page_load 08:15:20 INFO - PROCESS | 845 | _x_x_mozilla_page_load_details 08:15:20 INFO - PROCESS | 845 | |i|pagename|runs| 08:15:20 INFO - PROCESS | 845 | |0;ai-astar;111;106;114;111;114;125;111;111;111;112 08:15:20 INFO - PROCESS | 845 | |1;audio-beat-detection;155;126;156;165;126;149;161;131;163;136 08:15:20 INFO - PROCESS | 845 | |2;audio-dft;163;162;164;161;162;162;163;178;165;163 08:15:20 INFO - PROCESS | 845 | |3;audio-fft;72;74;73;76;73;145;71;70;74;74 08:15:20 INFO - PROCESS | 845 | |4;audio-oscillator;95;98;139;95;95;95;137;96;96;144 08:15:20 INFO - PROCESS | 845 | |5;imaging-gaussian-blur;110;109;110;111;110;109;110;109;110;109 08:15:20 INFO - PROCESS | 845 | |6;imaging-darkroom;150;147;147;147;146;146;147;147;148;146 08:15:20 INFO - PROCESS | 845 | |7;imaging-desaturate;99;96;96;97;96;96;97;96;96;97 08:15:20 INFO - PROCESS | 845 | |8;json-parse-financial;59;59;58;59;60;60;66;62;62;57 08:15:20 INFO - PROCESS | 845 | |9;json-stringify-tinderbox;68;69;67;67;69;68;68;68;68;68 08:15:20 INFO - PROCESS | 845 | |10;stanford-crypto-aes;91;83;92;86;83;84;84;86;92;94 08:15:20 INFO - PROCESS | 845 | |11;stanford-crypto-ccm;118;117;120;125;126;130;117;128;127;122 08:15:20 INFO - PROCESS | 845 | |12;stanford-crypto-pbkdf2;138;149;149;150;140;139;147;147;150;149 08:15:20 INFO - PROCESS | 845 | |13;stanford-crypto-sha256-iterative;69;69;70;66;71;69;67;68;74;68 08:15:20 INFO - PROCESS | 845 | __end_tp_report 08:15:20 INFO - PROCESS | 845 | __start_cc_report 08:15:20 INFO - PROCESS | 845 | _x_x_mozilla_cycle_collect,766 08:15:20 INFO - PROCESS | 845 | __end_cc_report 08:15:20 INFO - PROCESS | 845 | __startTimestamp1452788120471__endTimestamp 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | ------- Summary: start ------- 08:15:20 INFO - PROCESS | 845 | Number of tests: 14 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#0] ai-astar Cycles:10 Average:112.60 Median:111.50 stddev:4.88 (4.4%) stddev-sans-first:5.14 08:15:20 INFO - PROCESS | 845 | Values: 111.0 106.0 114.0 111.0 114.0 125.0 111.0 111.0 111.0 112.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:155.50 stddev:15.58 (10.0%) stddev-sans-first:16.24 08:15:20 INFO - PROCESS | 845 | Values: 155.0 126.0 156.0 165.0 126.0 149.0 161.0 131.0 163.0 136.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.95 (3.0%) stddev-sans-first:5.22 08:15:20 INFO - PROCESS | 845 | Values: 163.0 162.0 164.0 161.0 162.0 162.0 163.0 178.0 165.0 163.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#3] audio-fft Cycles:10 Average:80.20 Median:73.50 stddev:22.83 (31.1%) stddev-sans-first:24.02 08:15:20 INFO - PROCESS | 845 | Values: 72.0 74.0 73.0 76.0 73.0 145.0 71.0 70.0 74.0 74.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:21.48 (22.6%) stddev-sans-first:22.18 08:15:20 INFO - PROCESS | 845 | Values: 95.0 98.0 139.0 95.0 95.0 95.0 137.0 96.0 96.0 144.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:15:20 INFO - PROCESS | 845 | Values: 110.0 109.0 110.0 111.0 110.0 109.0 110.0 109.0 110.0 109.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:0.67 08:15:20 INFO - PROCESS | 845 | Values: 150.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 148.0 146.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:0.50 08:15:20 INFO - PROCESS | 845 | Values: 99.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:2.57 (4.3%) stddev-sans-first:2.69 08:15:20 INFO - PROCESS | 845 | Values: 59.0 59.0 58.0 59.0 60.0 60.0 66.0 62.0 62.0 57.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:15:20 INFO - PROCESS | 845 | Values: 68.0 69.0 67.0 67.0 69.0 68.0 68.0 68.0 68.0 68.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.50 stddev:4.28 (4.8%) stddev-sans-first:4.34 08:15:20 INFO - PROCESS | 845 | Values: 91.0 83.0 92.0 86.0 83.0 84.0 84.0 86.0 92.0 94.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:125.50 stddev:4.83 (3.8%) stddev-sans-first:4.77 08:15:20 INFO - PROCESS | 845 | Values: 118.0 117.0 120.0 125.0 126.0 130.0 117.0 128.0 127.0 122.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:149.00 stddev:4.83 (3.2%) stddev-sans-first:4.21 08:15:20 INFO - PROCESS | 845 | Values: 138.0 149.0 149.0 150.0 140.0 139.0 147.0 147.0 150.0 149.0 08:15:20 INFO - PROCESS | 845 | 08:15:20 INFO - PROCESS | 845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:2.23 (3.2%) stddev-sans-first:2.37 08:15:20 INFO - PROCESS | 845 | Values: 69.0 69.0 70.0 66.0 71.0 69.0 67.0 68.0 74.0 68.0 08:15:20 INFO - PROCESS | 845 | -------- Summary: end -------- 08:15:20 INFO - PROCESS | 845 | 08:15:21 INFO - TEST-INFO | 845: exit 0 08:15:21 INFO - TEST-OK | kraken | took 60261ms 08:15:21 INFO - TEST-START | v8_7 08:15:21 INFO - operating with platform_type : linux_ 08:15:21 INFO - Initialising browser for v8_7 test... 08:15:21 INFO - TEST-INFO | started process 1151 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjntitm/profile http://localhost:55860/getInfo.html) 08:15:24 INFO - PROCESS | 1151 | 08:15:24 INFO - PROCESS | 1151 | (process:1288): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:15:25 INFO - PROCESS | 1151 | __metrics Screen width/height:1600/1200 08:15:25 INFO - PROCESS | 1151 | colorDepth:24 08:15:25 INFO - PROCESS | 1151 | Browser inner width/height: 1024/697 08:15:25 INFO - PROCESS | 1151 | __metrics 08:15:25 INFO - PROCESS | 1151 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:15:26 INFO - TEST-INFO | 1151: exit 0 08:15:26 INFO - Browser initialized. 08:15:26 INFO - Running cycle 1/1 for v8_7 test... 08:15:26 INFO - TEST-INFO | started process 1337 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjntitm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:28 INFO - PROCESS | 1337 | 08:15:28 INFO - PROCESS | 1337 | (process:1396): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:15:38 INFO - PROCESS | 1337 | RSS: Main: 150126592 08:15:38 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | Cycle 1(1): loaded http://localhost:55860/tests/v8_7/run.html (next: http://localhost:55860/tests/v8_7/run.html) 08:16:01 INFO - PROCESS | 1337 | RSS: Main: 144961536 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | __start_tp_report 08:16:01 INFO - PROCESS | 1337 | _x_x_mozilla_page_load 08:16:01 INFO - PROCESS | 1337 | _x_x_mozilla_page_load_details 08:16:01 INFO - PROCESS | 1337 | |i|pagename|runs| 08:16:01 INFO - PROCESS | 1337 | |0;Richards;167.9261125104954 08:16:01 INFO - PROCESS | 1337 | |1;DeltaBlue;188.5014137606032 08:16:01 INFO - PROCESS | 1337 | |2;Encrypt;280.0336040324839 08:16:01 INFO - PROCESS | 1337 | |3;Decrypt;5196.891191709845 08:16:01 INFO - PROCESS | 1337 | |4;RayTrace;1057.0824524312895 08:16:01 INFO - PROCESS | 1337 | |5;Earley;716.3323782234957 08:16:01 INFO - PROCESS | 1337 | |6;Boyer;12231.707317073171 08:16:01 INFO - PROCESS | 1337 | |7;RegExp;40740 08:16:01 INFO - PROCESS | 1337 | |8;Splay;583.7711617046118 08:16:01 INFO - PROCESS | 1337 | |9;NavierStokes;4873.78640776699 08:16:01 INFO - PROCESS | 1337 | __end_tp_report 08:16:01 INFO - PROCESS | 1337 | __startTimestamp1452788161435__endTimestamp 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | ------- Summary: start ------- 08:16:01 INFO - PROCESS | 1337 | Number of tests: 10 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#0] Richards Cycles:1 Average:167.93 Median:167.93 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 167.9 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 188.5 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 280.0 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 5196.9 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#4] RayTrace Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 1057.1 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 716.3 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 12231.7 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#7] RegExp Cycles:1 Average:40740.00 Median:40740.00 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 40740.0 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#8] Splay Cycles:1 Average:583.77 Median:583.77 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 583.8 08:16:01 INFO - PROCESS | 1337 | 08:16:01 INFO - PROCESS | 1337 | [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 08:16:01 INFO - PROCESS | 1337 | Values: 4873.8 08:16:01 INFO - PROCESS | 1337 | -------- Summary: end -------- 08:16:01 INFO - PROCESS | 1337 | 08:16:02 INFO - TEST-INFO | 1337: exit 0 08:16:02 INFO - TEST-OK | v8_7 | took 40969ms 08:16:02 INFO - SUITE-END | took 1211s 08:16:02 INFO - Completed test suite (00:20:11) 08:16:02 INFO - Working with test: dromaeo_css 08:16:02 INFO - Generating results file: dromaeo_css 08:16:02 INFO - Working with test: kraken 08:16:02 INFO - Generating results file: kraken 08:16:02 INFO - javascript benchmark 08:16:02 INFO - Working with test: v8_7 08:16:02 INFO - Generating results file: v8_7 08:16:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:16:02 INFO - process_Request line: dromaeo_css 6679.26 graph.html#tests=[[72,64,43]] 08:16:02 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:02 INFO - process_Request line: kraken 1519.90 graph.html#tests=[[232,64,43]] 08:16:02 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:02 INFO - process_Request line: v8_7 20448.20 graph.html#tests=[[230,64,43]] 08:16:02 INFO - RETURN: dromaeo_css: 6679.26 08:16:02 INFO - RETURN: kraken: 1519.90 08:16:02 INFO - RETURN: v8_7: 20448.20 08:16:02 INFO - javascript benchmark 08:16:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3117.7817552771303, 3138.325260069085, 3169.429502689515, 3175.5363139067967, 3187.0279564732746, 4815.711057336563, 5036.3200967869325, 5066.746662666866, 5073.467285934979, 5093.898122037557, 4876.463589005207, 4985.127602669537, 5025.3718285214345, 5043.420006699231, 5055.898882022358, 4575.428071491064, 4642.512536183686, 4660.836870709526, 4714.811407543694, 4732.597729193023, 4493.910121797562, 4588.24293991491, 4611.792469338871, 4625.838095666652, 4661.137689527448, 4500.234960056799, 4514.841980530666, 4580.450345958473, 4612.7001744886475, 4612.930806037912, 4525.275955847049, 4530.22986092365, 4541.704789188692, 4547.8635640930825, 4613.700109492872, 4414.3157810539415, 4488.618467430272, 4561.954380456186, 4564.338170965225, 4567.954320456786, 4817.542333478314, 4832.710037397767, 4845.055214233226, 4866.562009419169, 4911.729854857981, 5292.550133238679, 5337.439568845254, 5357.571394288448, 5381.139017757179, 5435.945640543583, 5269.420363760021, 5298.205269209611, 5339.946600533984, 5413.160960051198, 5420.051490989061, 5038.7984480620735, 5063.544281014726, 5075.619328550337, 5102.209157580581, 5113.897722045575, 5457.754401051962, 5474.781008759605, 5475.425080366584, 5490.505854473116, 5504.53211477029, 5141.38303403594, 5215.608829337815, 5297.470252974672, 5321.6540924839765, 5342.1452567589, 5390.838274851761, 5396.028714831289, 5396.568274538027, 5411.0, 5424.538914192259, 5332.493413125747, 5361.892762144813, 5385.7576409061685, 5389.218563308298, 5438.021156191844, 5263.34208223972, 5330.360356757214, 5367.275417818544, 5374.247605335257, 5432.049391356497, 4191.895202619898, 4207.894802629959, 4224.78876056196, 4239.9788001060415, 4250.298700714409, 3803.82882770276, 3825.9669889130337, 3827.5215598050245, 3832.0419895026243, 3848.7113466490127, 4963.726995015237, 4988.102141614544, 5006.374203224597, 5026.54761071498, 5028.220625803006, 5383.896301258233, 5385.353757549119, 5409.350877894678, 5415.1335786274, 5445.809396671098, 4955.231939049453, 5026.0, 5030.446650868402, 5031.798728050837, 5079.263506791494, 4536.319552067151, 4541.704789188692, 4583.564561366665, 4590.081983603292, 4602.447706275201, 5525.281713377235, 5527.751251193706, 5529.972350138223, 5531.529819965348, 5564.527015203672, 5345.278387417727, 5354.197714853452, 5365.651232669864, 5370.650907690988, 5416.647917885325, 5369.57043436532, 5465.6447330923365, 5480.26016487785, 5515.145152501369, 5553.611247212656, 5333.040052790535, 5338.519533242027, 5345.518903298722, 5348.171033489815, 5367.973160134175, 5390.218418329242, 5413.079776438094, 5424.566034717134, 5443.074677304789, 5479.671219726829, 5113.718745469035, 5176.637635365639, 5258.0009798138235, 5289.100852855101, 5348.358197016383, 5246.97376513115, 5263.421023687315, 5275.366955965309, 5285.048691235615, 5291.470852914677, 5036.169032109661, 5153.742312884416, 5200.297959775533, 5201.401838788436, 5221.660592061504, 5157.638965272395, 5249.107651699144, 5320.06898792702, 5323.1216849219445, 5370.140777475585, 5162.586993040472, 5186.09243382399, 5193.506616871391, 5210.609204309616, 5216.895662086813], "unit": "score", "name": "dojo.html", "value": 4967.6979133584655}, {"lowerIsBetter": false, "replicates": [515.6081378152603, 546.5982502860397, 547.5099785691808, 571.8570357410647, 578.5458415144111, 34225.0, 34679.30641387171, 34681.826590867044, 34801.47797783029, 34824.303513929706, 35124.0, 35502.64497355032, 35598.82200588993, 35727.4640880387, 35747.106322341955, 8219.260266576008, 8430.662773489054, 8431.3254939605, 8435.451695639795, 8435.83128337433, 8247.628856701433, 8334.749957501284, 8339.874901876477, 8340.87488687667, 8380.83238335233, 8273.958630206871, 8397.748067557983, 8410.831783364329, 8449.662013519483, 8455.112213217615, 8232.83534329313, 8341.45780524264, 8344.916550834536, 8388.8741668875, 8401.201885820838, 8138.470999385021, 8268.0, 8272.710455134042, 8272.8345433091, 8312.085670576233, 34281.14297142567, 34516.0, 34639.30721385558, 34753.82623086894, 34792.13019674503, 3176.0948129783133, 3302.554155189067, 3357.5467311912826, 3376.9831150844334, 3383.340248651514, 28402.28994275139, 28668.13995580115, 28725.0, 28880.71119288801, 29047.0, 3209.2297848516423, 3230.2893363460003, 3304.3886880927107, 3364.66353364664, 3422.0760394693293, 267155.0, 267452.0, 268582.0, 268942.0, 269121.0, 50597.24104138441, 51862.74068629708, 51907.48092519026, 51921.48078519166, 51985.0, 46948.5305146951, 62752.37247627557, 63133.0, 63303.0, 63520.68239658864, 15259.237038148049, 15495.14776687293, 15637.843621563867, 15661.921690391475, 15662.530124096294, 12133.69665758363, 12209.877901221053, 12245.204061735958, 12321.322327272086, 12365.814512782135, 18608.906955465405, 18718.344857929907, 18721.344752933583, 18732.344367947328, 19444.319448819224, 7823.100343460575, 7966.721164759206, 7995.560244186626, 8018.358531317481, 8109.310708589718, 907.382979573883, 931.2643012020428, 982.1013772398176, 1001.9699409017741, 1045.2630895218851, 27191.456170876867, 27576.586351204747, 27793.0, 27899.721002790116, 27974.160775176777, 1077.9676609701721, 1108.4568561405015, 1109.872364678056, 1130.63819577736, 1142.526718774915, 14236.715265694835, 14507.419703211754, 14629.487967921072, 14645.926770366294, 14661.34023968924, 310526.0, 312999.0, 313708.0, 315072.0, 315086.0, 47990.0, 48000.0, 48107.0, 48153.51846481561, 48355.5164448351, 1293.4438191577713, 1321.3525372567565, 1325.8342707161605, 1352.5063351876495, 1364.126958746403, 26774.732252677222, 26945.730542695106, 30327.24181895382, 30833.633057586627, 31312.217194569406, 43971.56028439675, 44139.55860441483, 44389.11221775611, 44571.55428445674, 44666.776666116464, 287425.0, 289175.0, 289671.0, 290836.0, 291522.0, 35405.46891796677, 36777.63222367742, 39942.600573993885, 42234.15531689287, 42259.0, 38579.0, 39232.607673922896, 39370.40944385779, 39677.0, 39816.60183398129, 33462.16344591307, 33476.330473389906, 34010.82994585011, 34183.487247690806, 34589.82705086459, 33240.33598400648, 35458.46812297766, 35775.64224357723, 36229.275414491036, 36361.09097272589, 34415.483767743004, 34977.825110874284, 35006.82496587501, 35178.64821351856, 35238.11904702403, 30348.393032138792, 31136.68863311338, 32657.510137347483, 32781.360931953786, 32800.50799238061, 24449.620855429308, 24670.383240419134, 24804.37989050288, 25036.123735669164, 25157.622635660846], "unit": "score", "name": "ext.html", "value": 17879.73132611198}, {"lowerIsBetter": false, "replicates": [346.93663920084936, 348.0359404449674, 351.29915817943197, 351.546505008539, 355.7100962715388, 15151.39394424223, 15552.222388880553, 16463.67072658546, 16661.33354665812, 17295.654086918286, 11049.944750276258, 11187.0, 16643.0, 16680.0, 16714.749278760828, 4551.340055691914, 4872.610191184696, 4897.289892965536, 4906.877328066809, 4927.556519913207, 4796.112719146969, 4889.926651100236, 4891.828785992491, 4894.339264199323, 4929.65492415531, 5118.539331460168, 5254.763535640886, 5267.051930652481, 5308.336457942757, 5318.627696061278, 5189.792408303663, 5215.765290561915, 5224.45143259958, 5254.21186821976, 5410.5401040911565, 5220.216967454912, 5247.9737601311745, 5259.86850328741, 5270.604704647167, 5271.051210782058, 12840.743185136245, 18842.90578547112, 19439.3196238131, 19448.22207111714, 19548.31580894676, 1999.2402886902885, 2026.6554685703466, 2065.2255404223415, 2214.324630987548, 2270.194081101218, 9108.316876234308, 9343.2525397968, 11937.582184623583, 12461.1900226485, 12691.682707932283, 1740.1386313774763, 1812.9365472208542, 1817.919778947314, 1847.344192811546, 1850.2044121027952, 53586.0, 55043.449565504234, 55198.0, 56076.719616402064, 57007.14489282664, 9723.854142187873, 9900.108990190773, 9902.306838521234, 10026.398416095057, 10087.798244035079, 12858.357082145856, 12953.352332383532, 13001.219926804422, 13017.804732929013, 13046.54337098197, 7563.243675632392, 7594.696212151563, 7625.313721765067, 7630.160682324939, 7636.08366995964, 7408.592527411044, 7460.888086678704, 7486.064241969754, 7531.661075251627, 7554.811129721801, 3871.5160604924386, 3920.0395903003946, 4331.285337919208, 4373.387725718402, 4391.604755572014, 1807.5932915094, 1881.491997160759, 1884.679604467244, 3012.472817256971, 3020.3539071206246, 879.2131042716733, 904.8145130248283, 985.4875464758286, 1047.1308813684623, 1049.0558497352292, 15162.393504259706, 16088.356465741474, 16197.479929188205, 16278.43025494102, 16501.09243991568, 928.4058202750246, 945.394947233771, 950.4582388038751, 969.2488321550854, 970.5001924009141, 9043.231325337289, 9259.675911343205, 9569.61721531145, 9585.664501742545, 9598.088181622734, 391548.0, 393769.0, 398705.0, 553056.2347188238, 556957.0, 67572.0, 71521.0, 71711.2828871715, 73452.63273683704, 74925.99999999891, 1126.380490730095, 1142.0977427832086, 1166.4284500594647, 1194.462491878658, 1208.6796998795326, 14491.637709056937, 14533.563993080224, 14793.038452500983, 14847.0, 15037.548873533811, 32264.0, 32725.836370817993, 33487.33025339528, 33776.0, 34149.0, 39517.0, 39771.0, 40507.39238911478, 40889.795551022056, 42571.57428425676, 7221.458390620619, 7430.591317477591, 7446.292602202782, 7458.403327733659, 7482.96258518704, 9044.954775226082, 10610.734731631772, 11249.437528123397, 11472.369019703663, 11625.24435911663, 8550.91449085526, 9333.906660933304, 9474.810503790024, 9714.659986900424, 9946.154576861049, 9770.31607787448, 9926.106650401498, 10111.443870587189, 10159.847602285823, 10332.276740628384, 10156.18750499973, 10337.9483102584, 10362.533685983997, 10449.529771160163, 10527.368357898551, 6354.23749150105, 6619.470442364695, 6700.0, 6736.326367363225, 6871.793846184622, 7840.607969601611, 8484.618192181244, 8521.105283945344, 8659.52372619512, 9073.90926090757], "unit": "score", "name": "jquery.html", "value": 8052.0301285487385}, {"lowerIsBetter": false, "replicates": [1405.276282714402, 1440.8126943497348, 1563.6638122803595, 1728.4814555633307, 1755.7805274340699, 6897.379235868771, 6918.377346038856, 6983.72065117396, 7071.823204419892, 7083.9645801770985, 7187.28127187281, 7218.4225261979045, 7255.310745479171, 7294.70821167154, 7295.525790823606, 2187.562487502498, 2191.747948985867, 2205.1730601024615, 2212.524307273936, 2216.9778302217014, 2186.289455926822, 2197.791209835071, 2255.8759268240324, 2277.20297895736, 2277.840551161419, 1890.7731072271347, 1927.7012063130167, 2225.3657707553352, 2227.187076716995, 2233.3300009997015, 2120.703101565782, 2142.4965133193764, 2167.2522979572022, 2167.349795061491, 2171.1966572368165, 2092.9790702092937, 2107.3993911735233, 2185.945351366213, 2191.5288213034114, 2195.5718634866207, 7030.683619237147, 7051.89422158668, 7055.2239253682055, 7078.929210707878, 7083.079199704057, 4268.466441694788, 4334.804933777988, 4354.238008348558, 4367.45406824147, 4381.408509851161, 2776.1810265971585, 2805.7474827265646, 2845.5447128459346, 2873.7126287371307, 2897.8116422432477, 910.2490445382585, 932.324065052838, 938.2119020023214, 956.383132879289, 961.0485619236975, 8960.283177345797, 9091.909080909238, 9113.179813816789, 9125.680601178994, 9132.767076444728, 3693.464447655129, 3792.905177370588, 3833.15670552478, 3913.3934240192248, 3923.136909879822, 7663.578503182267, 7677.9232207677205, 7704.422168337285, 7724.575148366781, 7732.845343093107, 4366.126774645084, 4371.846985355561, 4373.562643735665, 4374.147041326911, 4382.474103107647, 4079.184163167319, 4079.918401631951, 4080.673546116363, 4123.0516981094515, 4128.876133715993, 3246.8214248216573, 3310.519974603669, 3323.6344002159744, 3325.584301962255, 3327.1016825457473, 1040.9375437473775, 1058.1270451877233, 1060.1571750458404, 1067.2475904487317, 1072.0565902006185, 938.0994245524373, 938.643315540104, 1002.283367392318, 1241.1870225002458, 1268.2517314784322, 6449.871002579922, 6502.122213501211, 6555.180602424697, 6567.638779867153, 6623.834404139839, 1078.2613909472036, 1094.2121672395863, 1098.9450527473755, 1103.624767579027, 1143.999000874235, 5148.485151484896, 5192.376914770176, 5202.947970520247, 5220.686758794409, 5224.268602395668, 7974.920250797418, 8117.188281171835, 8251.876221856677, 8456.661733530713, 8457.281131103926, 8289.95855020721, 8308.501489910625, 8313.459625124347, 8318.251357377743, 8346.290565301895, 6731.115287719446, 6837.9658101710165, 6879.89680154798, 6882.8623427531165, 6918.066061081689, 6425.389587989133, 6430.935690643221, 6447.290798012309, 6449.0, 6455.806325810233, 7490.250974902466, 7622.9237707622215, 7781.26078022587, 7820.452568320163, 7827.45207835446, 7361.4110871129105, 7449.888251676338, 7489.8876516851205, 7866.803329916798, 7934.722284720238, 6134.325224225421, 6176.629402235881, 6228.564000520101, 6232.688365581612, 6233.968830156002, 6276.1213430118905, 6436.613803171825, 6456.289808121009, 6459.903101453576, 6627.635480048643, 6363.809085727436, 6447.9032814508755, 6494.967525162344, 6533.836654083686, 6549.050387693663, 6286.685665716787, 6288.748450061947, 6305.054241863757, 6386.457151142205, 6424.582402143846, 6260.561760676709, 6307.463865571294, 6317.5893566918, 6341.27075386318, 6354.0, 5822.359540450462, 5865.824025279248, 5893.2044174035955, 5930.28836539618, 5956.344802071855, 5906.970465147647, 5929.110633405024, 5937.910931335947, 5938.435848594377, 5977.491913187428], "unit": "score", "name": "mootools.html", "value": 4121.524215574334}, {"lowerIsBetter": false, "replicates": [326.60317713977526, 336.2400973799214, 338.0837929211836, 338.71717116207964, 346.65161512679754, 6255.7497700092, 6283.717232724527, 6311.779087731925, 6333.873322533546, 6404.391582799638, 6253.593516421441, 6276.246850377961, 6280.277768056663, 6285.9685701571425, 6305.369463053692, 4792.736399498026, 4798.880027999293, 4801.639877009238, 4817.01251243496, 4818.084563932859, 4821.180399332105, 4821.2768084787385, 4822.710637361752, 4823.855284341475, 4833.32333473314, 4672.97663511682, 4765.166095933215, 4767.332573439721, 4772.856814295576, 4777.5222477752295, 4762.761861906891, 4768.546988036148, 4779.235322348408, 4783.258594917776, 4796.304535842318, 4135.379693046037, 4142.772147531885, 4149.356849688304, 4152.211079894811, 4155.625993660585, 6010.188624535675, 6030.577859549833, 6040.426159514839, 6043.697815109271, 6094.786682466092, 5428.0, 5515.669059856381, 5532.253145825302, 5532.533878522195, 5549.6115271930985, 6628.072069910217, 6653.068570400148, 6662.133922590081, 6672.833179170511, 6678.465722742218, 4550.817967281338, 4568.497465278817, 4583.0604726031415, 4587.72473651582, 4590.036092420596, 6756.155480564929, 6839.179298484164, 6915.723371065152, 6918.481113916426, 6921.411680007205, 4627.490975992706, 4638.721676699409, 4645.953540464552, 4646.697964632288, 4668.393108895822, 4699.177643912301, 4705.270683044134, 4707.270373092176, 4709.387779588632, 4718.669693121448, 5493.313335833021, 5494.2857428534035, 5497.175423686479, 5507.586930980193, 5511.0, 6472.05838248533, 6658.500612454085, 6675.732970681215, 6676.766313179112, 6695.12963314766, 1599.8880078394634, 1601.5595711179285, 1630.853223209893, 1631.111044480761, 1647.3657641807752, 1088.1947358954317, 1109.8168802147716, 1112.4548971004149, 1112.5549780087867, 1116.1851848150734, 6138.815835524942, 6211.2857021443115, 6271.090691849748, 6312.179416675803, 6315.905261421082, 6724.495662825308, 6760.594364338155, 6768.932310676831, 6786.966065169642, 6809.863802724017, 6144.477719393813, 6193.0, 6247.500199983991, 6250.718717657716, 6276.874462510724, 3694.0, 3707.870224542128, 3715.3126671565847, 3722.7021838252876, 3723.422869455239, 7022.4733145014325, 7061.152661680529, 7082.964585177041, 7083.574985500886, 7095.219525852152, 6774.661266936633, 6917.9308206917285, 6948.5483443576, 6957.756478523227, 6959.095317608679, 6992.825179370455, 7009.7897063088185, 7011.193712723, 7014.754483593049, 7020.824479387954, 6751.662416879235, 6790.524663273523, 6796.456283497408, 6797.898031529432, 6800.387965082969, 6547.050677651619, 6638.0, 6679.365460281266, 6681.966590167018, 6683.064370987969, 6994.195667498099, 7048.577085374894, 7059.647017649199, 7064.788056358318, 7075.752348667772, 4563.498015218257, 4573.839915602938, 4573.931391029204, 4574.931376029429, 4579.954200458086, 6786.728530858711, 6788.49086318538, 6788.96605516989, 6798.320167983162, 6956.2695916928, 6724.596524208563, 6737.3599508046655, 6750.426213771884, 6775.0, 6777.08509351251, 6705.430038446787, 6726.764563240263, 6728.360805723449, 6730.899036514554, 6737.59574425536, 6460.353964603502, 6507.967460162668, 6532.444742196966, 6585.176852893388, 6597.241317248386, 6749.966250168718, 6754.0, 6755.088063111417, 6772.424343930821, 6781.11845460087, 6545.607263564011, 6579.144711187515, 6583.604983700993, 6586.110875032001, 6589.8797204474395], "unit": "score", "name": "prototype.html", "value": 4982.814760429874}, {"lowerIsBetter": false, "replicates": [681.7852376501402, 687.0415770000849, 757.696921231507, 778.5717855179649, 784.7920301120204, 13118.868811311884, 13159.736805263889, 13192.868071319284, 13281.070325077248, 13306.135101218426, 12954.80567791484, 13098.41057152428, 13100.41048152833, 13172.407241674124, 13199.604011879635, 782.7103971530541, 790.4111436979458, 791.4934441957153, 794.6980147543954, 808.5633757770797, 813.2396209544065, 815.4251252866744, 816.7059858450982, 820.5856042698429, 821.843849668561, 837.3552364679193, 839.202757380491, 839.9962045355802, 845.3026253341018, 846.1453931529138, 827.4580150001728, 836.7322456813761, 839.920207580282, 841.9896124650444, 843.5992903370911, 615.7783198048699, 622.6202016769766, 624.2820756130441, 624.3475568031419, 625.8904691678983, 13316.067875248737, 13473.124246923919, 13544.45822167112, 13589.864101358959, 13650.726985460235, 11266.605668801634, 11294.0, 11419.625362098377, 11602.361870097142, 11625.941870290679, 10074.143697785697, 10465.581376744922, 10587.78824423515, 10663.840042399293, 10906.61826836057, 3507.8070706111153, 3565.964340356615, 3577.910552236189, 3581.4627805829073, 3589.94615080774, 46420.7678961603, 46633.53366466292, 46642.30036549454, 46838.53161468376, 47045.0, 9400.576974036185, 9627.5667594957, 9646.710598682052, 9801.362911410735, 9936.900630993741, 16845.747313790303, 16915.23881425314, 16931.661366772594, 16935.66128677444, 16977.236024378686, 7092.148942126978, 7278.381337586365, 7308.086489188851, 7360.07999000125, 7491.587962662106, 4033.092554175287, 4052.1895620875944, 4067.430559721641, 4153.273177193979, 4167.937480937789, 2817.0985284708695, 2838.4181242845166, 2840.616516770251, 2841.971580284212, 2851.158908122109, 518.2174915877052, 539.719345940109, 540.235566673161, 545.9235707001023, 546.8304825504027, 540.6404740847292, 571.4999375546397, 637.5377851057946, 643.0482885329739, 696.7944456385378, 7932.643031063616, 8100.2304781045705, 8930.910690893137, 9205.171534561921, 9257.166854982948, 513.6661170239374, 535.1063723581628, 606.5283425846231, 623.5261201486902, 669.5480550628404, 3834.5620392352866, 3894.4937158169823, 3945.2109578084496, 3957.0, 3973.8013099345494, 50766.74616626893, 51033.489665102876, 51134.48865511372, 51986.22020669693, 52620.210696839575, 46990.4271538901, 47572.28641570379, 47704.522954770706, 48246.0, 48681.26978095331, 43161.0, 43684.12631747347, 43747.34378984254, 44030.779846100566, 44128.3380749289, 7737.226277372218, 7773.222677732181, 7848.960755196187, 7912.248336408032, 7993.880091798744, 32218.19454513656, 32272.0, 32794.18014549655, 33120.0, 33148.1712957178, 39890.0, 39936.80031599823, 41305.380419293135, 41779.164416712105, 42404.1519169621, 9880.0, 9902.900970990198, 9959.950200248952, 10164.949175254373, 10178.440185789852, 11839.28964262147, 12053.57812476559, 12146.696332591757, 12162.148649594443, 12589.18170318963, 9928.602855885973, 10093.142082923034, 10124.797504050026, 11624.334084877937, 11747.706307342043, 10952.388045620932, 11185.552577896793, 11565.653030409101, 11652.0, 11690.941545292219, 10199.224521771863, 10491.160707143257, 10567.0, 10653.680389588324, 10843.891561084289, 8786.692465763668, 9231.723048308562, 9256.72229833106, 9379.968203497474, 9557.139857412867, 8277.420580559303, 8517.44636598619, 8518.403711740119, 8930.240929521064, 9833.065858743408], "unit": "score", "name": "yui.html", "value": 6044.706388646061}], "name": "dromaeo_css", "value": 6679.257843830211}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 114.0, 111.0, 114.0, 125.0, 111.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 156.0, 165.0, 126.0, 149.0, 161.0, 131.0, 163.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 164.0, 161.0, 162.0, 162.0, 163.0, 178.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 76.0, 73.0, 145.0, 71.0, 70.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 139.0, 95.0, 95.0, 95.0, 137.0, 96.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [99.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 58.0, 59.0, 60.0, 60.0, 66.0, 62.0, 62.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 92.0, 86.0, 83.0, 84.0, 84.0, 86.0, 92.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 120.0, 125.0, 126.0, 130.0, 117.0, 128.0, 127.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 149.0, 150.0, 140.0, 139.0, 147.0, 147.0, 150.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 66.0, 71.0, 69.0, 67.0, 68.0, 74.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1519.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.9261125104954], "unit": "score", "name": "Richards", "value": 210.22340999999997}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1057.0824524312895], "unit": "score", "name": "RayTrace", "value": 700.0295939999999}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [40740.0], "unit": "score", "name": "RegExp", "value": 22.360947471772207}, {"lowerIsBetter": false, "replicates": [583.7711617046118], "unit": "score", "name": "Splay", "value": 139.59408299999993}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 20448.203462075013}]} 08:16:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20448.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1519.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6679.26"}}} 08:16:02 INFO - Return code: 0 08:16:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:16:02 INFO - # TBPL SUCCESS # 08:16:02 INFO - Running post-action listener: _resource_record_post_action 08:16:02 INFO - Running post-run listener: _resource_record_post_run 08:16:03 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 553144320; Read time: 272; Write time: 433116 08:16:03 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 239468544; Read time: 108; Write time: 275560 08:16:03 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 313675776; Read time: 164; Write time: 157556 08:16:03 INFO - Running post-run listener: _upload_blobber_files 08:16:03 INFO - Blob upload gear active. 08:16:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:16:03 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 08:16:03 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'] 08:16:03 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 08:16:04 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:05 INFO - (blobuploader) - INFO - Done attempting. 08:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:05 INFO - (blobuploader) - INFO - Done attempting. 08:16:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:05 INFO - Return code: 0 08:16:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:16:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c60bf9648a5c2aaf94a227c76f1919f5c507e11e5e7f7d07a9d62b61f0af259faa1a739d3050909e2b43175e07e4b1e7e702149ff75555143cfaf1d68cd90c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd15e44aa862feec4212fad71ed1caa0f036a302591a3bba5c29c64234e205b20cd08a0a1eb9578dd41e1d5f586d3815248805fb3817f880496260d565b2279"} 08:16:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:16:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:16:05 INFO - Contents: 08:16:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c60bf9648a5c2aaf94a227c76f1919f5c507e11e5e7f7d07a9d62b61f0af259faa1a739d3050909e2b43175e07e4b1e7e702149ff75555143cfaf1d68cd90c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd15e44aa862feec4212fad71ed1caa0f036a302591a3bba5c29c64234e205b20cd08a0a1eb9578dd41e1d5f586d3815248805fb3817f880496260d565b2279"} 08:16:05 INFO - Copying logs to upload dir... 08:16:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.716150 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-14 08:16:05.833643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 08:16:05.837555) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 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/7c60bf9648a5c2aaf94a227c76f1919f5c507e11e5e7f7d07a9d62b61f0af259faa1a739d3050909e2b43175e07e4b1e7e702149ff75555143cfaf1d68cd90c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd15e44aa862feec4212fad71ed1caa0f036a302591a3bba5c29c64234e205b20cd08a0a1eb9578dd41e1d5f586d3815248805fb3817f880496260d565b2279"} build_url:https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/Z1fXfYytR6GPB7e7OQSVvw/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/7c60bf9648a5c2aaf94a227c76f1919f5c507e11e5e7f7d07a9d62b61f0af259faa1a739d3050909e2b43175e07e4b1e7e702149ff75555143cfaf1d68cd90c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd15e44aa862feec4212fad71ed1caa0f036a302591a3bba5c29c64234e205b20cd08a0a1eb9578dd41e1d5f586d3815248805fb3817f880496260d565b2279"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 08:16:05.862096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:16:05.862428) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452786894.528842-1061608806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:16:05.948303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 08:16:05.948633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 08:16:05.948956) ========= ========= Total master_lag: 0.22 =========