builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1458317754.76 results: success (0) buildid: 20160318053015 builduid: 2734d5cfaa7541ef9de83f1f77ec26b2 revision: 571fa014bb35a2026fef866abe08daa52e599a46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.758494) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.758953) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.759297) ========= 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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005923 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.781683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.782003) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.794901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.795211) ========= 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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.843894) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.844205) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.844601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.844874) ========= 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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 09:15: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% 88.0M=0s 2016-03-18 09:15:55 (88.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.974477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:54.974799) ========= 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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:55.023783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:55.024144) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 571fa014bb35a2026fef866abe08daa52e599a46 --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 571fa014bb35a2026fef866abe08daa52e599a46 --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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 09:15:55,775 truncating revision to first 12 chars 2016-03-18 09:15:55,775 Setting DEBUG logging. 2016-03-18 09:15:55,775 attempt 1/10 2016-03-18 09:15:55,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/571fa014bb35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 09:15:56,115 unpacking tar archive at: fx-team-571fa014bb35/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634495 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:55.760221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:55.760790) ========= echo 571fa014bb35a2026fef866abe08daa52e599a46 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'571fa014bb35a2026fef866abe08daa52e599a46'] 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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 571fa014bb35a2026fef866abe08daa52e599a46 program finished with exit code 0 elapsedTime=0.004671 script_repo_revision: '571fa014bb35a2026fef866abe08daa52e599a46' ========= master_lag: 0.01 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:55.779094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:55.779397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:15:55.789239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-18 09:15:55.789607) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:56 INFO - MultiFileLogger online at 20160318 09:15:56 in /builds/slave/test-pgo 09:15:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:15:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:15:56 INFO - {'append_to_log': False, 09:15:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:15:56 INFO - 'blob_upload_branch': 'Fx-Team', 09:15:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:15:56 INFO - 'branch': 'Fx-Team', 09:15:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:56 INFO - 'config_files': ('talos/linux_config.py',), 09:15:56 INFO - 'default_actions': ('clobber', 09:15:56 INFO - 'read-buildbot-config', 09:15:56 INFO - 'download-and-extract', 09:15:56 INFO - 'populate-webroot', 09:15:56 INFO - 'create-virtualenv', 09:15:56 INFO - 'install', 09:15:56 INFO - 'run-tests'), 09:15:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:56 INFO - 'download_minidump_stackwalk': True, 09:15:56 INFO - 'download_symbols': 'ondemand', 09:15:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:56 INFO - 'installer_path': 'installer.exe', 09:15:56 INFO - 'log_level': 'info', 09:15:56 INFO - 'log_name': 'talos', 09:15:56 INFO - 'log_to_console': True, 09:15:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:56 INFO - 'opt_config_files': (), 09:15:56 INFO - 'pip_index': False, 09:15:56 INFO - 'sps_profile': False, 09:15:56 INFO - 'sps_profile_interval': 0, 09:15:56 INFO - 'suite': 'dromaeojs', 09:15:56 INFO - 'system_bits': '32', 09:15:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:56 INFO - 'title': 'talos-linux64-ix-043', 09:15:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:56 INFO - 'use_talos_json': True, 09:15:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:15:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:56 INFO - 'work_dir': 'build'} 09:15:56 INFO - ##### 09:15:56 INFO - ##### Running clobber step. 09:15:56 INFO - ##### 09:15:56 INFO - Running pre-action listener: _resource_record_pre_action 09:15:56 INFO - Running main action method: clobber 09:15:56 INFO - rmtree: /builds/slave/test-pgo/build 09:15:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:15:57 INFO - Running post-action listener: _resource_record_post_action 09:15:57 INFO - ##### 09:15:57 INFO - ##### Running read-buildbot-config step. 09:15:57 INFO - ##### 09:15:57 INFO - Running pre-action listener: _resource_record_pre_action 09:15:57 INFO - Running main action method: read_buildbot_config 09:15:57 INFO - Using buildbot properties: 09:15:57 INFO - { 09:15:57 INFO - "project": "", 09:15:57 INFO - "product": "firefox", 09:15:57 INFO - "script_repo_revision": "production", 09:15:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:15:57 INFO - "repository": "", 09:15:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:15:57 INFO - "buildid": "20160318053015", 09:15:57 INFO - "pgo_build": "True", 09:15:57 INFO - "basedir": "/builds/slave/test-pgo", 09:15:57 INFO - "buildnumber": 548, 09:15:57 INFO - "slavename": "talos-linux64-ix-043", 09:15:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:15:57 INFO - "platform": "ubuntu64_hw", 09:15:57 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:15:57 INFO - "branch": "fx-team", 09:15:57 INFO - "repo_path": "integration/fx-team", 09:15:57 INFO - "revision": "571fa014bb35a2026fef866abe08daa52e599a46", 09:15:57 INFO - "stage_platform": "linux64-pgo", 09:15:57 INFO - "builduid": "2734d5cfaa7541ef9de83f1f77ec26b2", 09:15:57 INFO - "slavebuilddir": "test" 09:15:57 INFO - } 09:15:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:15:57 INFO - Running post-action listener: _resource_record_post_action 09:15:57 INFO - ##### 09:15:57 INFO - ##### Running download-and-extract step. 09:15:57 INFO - ##### 09:15:57 INFO - Running pre-action listener: _resource_record_pre_action 09:15:57 INFO - Running main action method: download_and_extract 09:15:57 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:15: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')]} 09:15:57 INFO - https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:15:57 INFO - Downloaded 1361 bytes. 09:15:57 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:15:57 INFO - Using the following test package requirements: 09:15:57 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:15:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:15:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'jsshell-linux-x86_64.zip'], 09:15:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:15:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:15:57 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:15:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:15:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:15:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:15: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')]} 09:15:57 INFO - https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:58 INFO - Downloaded 23578669 bytes. 09:15:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:15:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:16:00 INFO - Return code: 0 09:16:00 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:00 INFO - https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:16:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:16:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:16:01 INFO - Downloaded 23578669 bytes. 09:16:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:16:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:16:02 INFO - Return code: 0 09:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:02 INFO - https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:16:03 INFO - Downloaded 10846565 bytes. 09:16:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:16:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:16:03 INFO - Return code: 0 09:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:03 INFO - https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:16:05 INFO - Downloaded 57613043 bytes. 09:16:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:16:05 INFO - mkdir: /builds/slave/test-pgo/properties 09:16:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:16:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:16:05 INFO - Contents: 09:16:05 INFO - build_url:https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:16:06 INFO - Running post-action listener: _resource_record_post_action 09:16:06 INFO - Running post-action listener: set_extra_try_arguments 09:16:06 INFO - ##### 09:16:06 INFO - ##### Running populate-webroot step. 09:16:06 INFO - ##### 09:16:06 INFO - Running pre-action listener: _resource_record_pre_action 09:16:06 INFO - Running main action method: populate_webroot 09:16:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:06 INFO - '--tppagecycles', 09:16:06 INFO - '7'], 09:16:06 INFO - 'tests': ['tsvgm']}}, 09:16:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:16:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:16:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'tests': ['damp', 'tps']}, 09:16:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['damp', 'tps']}, 09:16:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:16:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:06 INFO - 'other': {'tests': ['a11yr', 09:16:06 INFO - 'ts_paint', 09:16:06 INFO - 'tpaint', 09:16:06 INFO - 'sessionrestore', 09:16:06 INFO - 'sessionrestore_no_auto_restore', 09:16:06 INFO - 'tabpaint']}, 09:16:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['a11yr', 09:16:06 INFO - 'ts_paint', 09:16:06 INFO - 'tpaint', 09:16:06 INFO - 'sessionrestore', 09:16:06 INFO - 'sessionrestore_no_auto_restore', 09:16:06 INFO - 'tabpaint']}, 09:16:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['a11yr', 09:16:06 INFO - 'ts_paint', 09:16:06 INFO - 'tpaint', 09:16:06 INFO - 'sessionrestore', 09:16:06 INFO - 'sessionrestore_no_auto_restore', 09:16:06 INFO - 'tabpaint']}, 09:16:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['a11yr', 09:16:06 INFO - 'ts_paint', 09:16:06 INFO - 'tpaint', 09:16:06 INFO - 'sessionrestore', 09:16:06 INFO - 'sessionrestore_no_auto_restore', 09:16:06 INFO - 'tabpaint']}, 09:16:06 INFO - 'other_l64': {'tests': ['a11yr', 09:16:06 INFO - 'ts_paint', 09:16:06 INFO - 'tpaint', 09:16:06 INFO - 'sessionrestore', 09:16:06 INFO - 'sessionrestore_no_auto_restore', 09:16:06 INFO - 'tabpaint']}, 09:16:06 INFO - 'other_nol64': {'tests': ['a11yr', 09:16:06 INFO - 'ts_paint', 09:16:06 INFO - 'tpaint', 09:16:06 INFO - 'sessionrestore', 09:16:06 INFO - 'sessionrestore_no_auto_restore', 09:16:06 INFO - 'tabpaint']}, 09:16:06 INFO - 'svgr': {'tests': ['tsvgx', 09:16:06 INFO - 'tsvgr_opacity', 09:16:06 INFO - 'tart', 09:16:06 INFO - 'tscrollx', 09:16:06 INFO - 'cart']}, 09:16:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['tsvgx', 09:16:06 INFO - 'tsvgr_opacity', 09:16:06 INFO - 'tart', 09:16:06 INFO - 'tscrollx', 09:16:06 INFO - 'cart']}, 09:16:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'tests': ['tp5o']}, 09:16:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'talos_options': ['--e10s'], 09:16:06 INFO - 'tests': ['tp5o']}, 09:16:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'talos_options': ['--xperf_path', 09:16:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:06 INFO - 'tests': ['tp5n']}, 09:16:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:06 INFO - 'talos_options': ['--e10s', 09:16:06 INFO - '--xperf_path', 09:16:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:06 INFO - 'tests': ['tp5n']}}, 09:16:06 INFO - 'talos.zip': {'path': '', 09:16:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:06 INFO - Running post-action listener: _resource_record_post_action 09:16:06 INFO - ##### 09:16:06 INFO - ##### Running create-virtualenv step. 09:16:06 INFO - ##### 09:16:06 INFO - Running pre-action listener: _resource_record_pre_action 09:16:06 INFO - Running main action method: create_virtualenv 09:16:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:16:06 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 09:16:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:16:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:06 INFO - Using real prefix '/usr' 09:16:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:16:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:08 INFO - Installing pip.................done. 09:16:08 INFO - Return code: 0 09:16:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:16:08 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')]} 09:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:08 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')]} 09:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:16:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:08 INFO - Using env: {'DISPLAY': ':0', 09:16:08 INFO - 'HOME': '/home/cltbld', 09:16:08 INFO - 'LANG': 'en_US.UTF-8', 09:16:08 INFO - 'LANGUAGE': 'en_US:en', 09:16:08 INFO - 'LOGNAME': 'cltbld', 09:16:08 INFO - 'MAIL': '/var/mail/cltbld', 09:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:08 INFO - 'MOZ_NO_REMOTE': '1', 09:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:08 INFO - 'NO_EM_RESTART': '1', 09:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:08 INFO - 'SHELL': '/bin/bash', 09:16:08 INFO - 'SHLVL': '1', 09:16:08 INFO - 'TERM': 'linux', 09:16:08 INFO - 'TMOUT': '86400', 09:16:08 INFO - 'USER': 'cltbld', 09:16:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:08 INFO - '_': '/tools/buildbot/bin/python'} 09:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:09 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 09:16:09 INFO - Cleaning up... 09:16:09 INFO - Return code: 0 09:16:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:16:09 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')]} 09:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:09 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')]} 09:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:16:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:16:09 INFO - Using env: {'DISPLAY': ':0', 09:16:09 INFO - 'HOME': '/home/cltbld', 09:16:09 INFO - 'LANG': 'en_US.UTF-8', 09:16:09 INFO - 'LANGUAGE': 'en_US:en', 09:16:09 INFO - 'LOGNAME': 'cltbld', 09:16:09 INFO - 'MAIL': '/var/mail/cltbld', 09:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:09 INFO - 'MOZ_NO_REMOTE': '1', 09:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:09 INFO - 'NO_EM_RESTART': '1', 09:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:09 INFO - 'SHELL': '/bin/bash', 09:16:09 INFO - 'SHLVL': '1', 09:16:09 INFO - 'TERM': 'linux', 09:16:09 INFO - 'TMOUT': '86400', 09:16:09 INFO - 'USER': 'cltbld', 09:16:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:09 INFO - '_': '/tools/buildbot/bin/python'} 09:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:09 INFO - Downloading/unpacking psutil>=0.7.1 09:16:09 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 09:16:09 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 09:16:09 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 09:16:09 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 09:16:09 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 09:16:09 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 09:16:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:11 INFO - Installing collected packages: psutil 09:16:11 INFO - Running setup.py install for psutil 09:16:11 INFO - building 'psutil._psutil_linux' extension 09:16:11 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 09:16:11 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 09:16:11 INFO - building 'psutil._psutil_posix' extension 09:16:11 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 09:16:11 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 09:16:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:11 INFO - Successfully installed psutil 09:16:11 INFO - Cleaning up... 09:16:11 INFO - Return code: 0 09:16:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:16:11 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')]} 09:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:11 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')]} 09:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:16:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:16:11 INFO - Using env: {'DISPLAY': ':0', 09:16:11 INFO - 'HOME': '/home/cltbld', 09:16:11 INFO - 'LANG': 'en_US.UTF-8', 09:16:11 INFO - 'LANGUAGE': 'en_US:en', 09:16:11 INFO - 'LOGNAME': 'cltbld', 09:16:11 INFO - 'MAIL': '/var/mail/cltbld', 09:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:11 INFO - 'MOZ_NO_REMOTE': '1', 09:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:11 INFO - 'NO_EM_RESTART': '1', 09:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:11 INFO - 'SHELL': '/bin/bash', 09:16:11 INFO - 'SHLVL': '1', 09:16:11 INFO - 'TERM': 'linux', 09:16:11 INFO - 'TMOUT': '86400', 09:16:11 INFO - 'USER': 'cltbld', 09:16:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:11 INFO - '_': '/tools/buildbot/bin/python'} 09:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:16:12 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 09:16:12 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 09:16:12 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 09:16:12 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 09:16:12 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 09:16:12 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 09:16:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:16:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:16:13 INFO - Installing collected packages: mozsystemmonitor 09:16:13 INFO - Running setup.py install for mozsystemmonitor 09:16:14 INFO - Successfully installed mozsystemmonitor 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:16:14 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')]} 09:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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')]} 09:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:16:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:16:14 INFO - Using env: {'DISPLAY': ':0', 09:16:14 INFO - 'HOME': '/home/cltbld', 09:16:14 INFO - 'LANG': 'en_US.UTF-8', 09:16:14 INFO - 'LANGUAGE': 'en_US:en', 09:16:14 INFO - 'LOGNAME': 'cltbld', 09:16:14 INFO - 'MAIL': '/var/mail/cltbld', 09:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:14 INFO - 'MOZ_NO_REMOTE': '1', 09:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:14 INFO - 'NO_EM_RESTART': '1', 09:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:14 INFO - 'SHELL': '/bin/bash', 09:16:14 INFO - 'SHLVL': '1', 09:16:14 INFO - 'TERM': 'linux', 09:16:14 INFO - 'TMOUT': '86400', 09:16:14 INFO - 'USER': 'cltbld', 09:16:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:14 INFO - '_': '/tools/buildbot/bin/python'} 09:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:14 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 09:16:14 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 09:16:14 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 09:16:14 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 09:16:14 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 09:16:14 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 09:16:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:16:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 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 09:16:16 INFO - Downloading docopt-0.6.1.tar.gz 09:16:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:16 INFO - Running setup.py install for blobuploader 09:16:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:16:16 INFO - Running setup.py install for requests 09:16:17 INFO - Running setup.py install for docopt 09:16:17 INFO - Successfully installed blobuploader requests docopt 09:16:17 INFO - Cleaning up... 09:16:17 INFO - Return code: 0 09:16:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:16: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')]} 09:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:16:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:17 INFO - Using env: {'DISPLAY': ':0', 09:16:17 INFO - 'HOME': '/home/cltbld', 09:16:17 INFO - 'LANG': 'en_US.UTF-8', 09:16:17 INFO - 'LANGUAGE': 'en_US:en', 09:16:17 INFO - 'LOGNAME': 'cltbld', 09:16:17 INFO - 'MAIL': '/var/mail/cltbld', 09:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:17 INFO - 'MOZ_NO_REMOTE': '1', 09:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:17 INFO - 'NO_EM_RESTART': '1', 09:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:17 INFO - 'SHELL': '/bin/bash', 09:16:17 INFO - 'SHLVL': '1', 09:16:17 INFO - 'TERM': 'linux', 09:16:17 INFO - 'TMOUT': '86400', 09:16:17 INFO - 'USER': 'cltbld', 09:16:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:17 INFO - '_': '/tools/buildbot/bin/python'} 09:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:16:17 INFO - Running setup.py (path:/tmp/pip-SWPQjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:16:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:16:17 INFO - Running setup.py (path:/tmp/pip-higoj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:16:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:16:17 INFO - Running setup.py (path:/tmp/pip-XgPbTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:16:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:16:17 INFO - Running setup.py (path:/tmp/pip-vTpvkL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:16:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:16:17 INFO - Running setup.py (path:/tmp/pip-7wbAVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:16:18 INFO - Running setup.py (path:/tmp/pip-lRPFgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:16:18 INFO - Running setup.py (path:/tmp/pip-dxwuPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:16:18 INFO - Running setup.py (path:/tmp/pip-r9F14R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:16:18 INFO - Running setup.py (path:/tmp/pip-mhSvAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:16:18 INFO - Running setup.py (path:/tmp/pip-Lm1d9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:16:18 INFO - Running setup.py (path:/tmp/pip-H2_eov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:16:18 INFO - Running setup.py (path:/tmp/pip-RdKDRc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:16:18 INFO - Running setup.py (path:/tmp/pip-BLfIbN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:16:18 INFO - Running setup.py (path:/tmp/pip-KQP4zX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:16:18 INFO - Running setup.py (path:/tmp/pip-ggG9vP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:16:18 INFO - Running setup.py (path:/tmp/pip-st4oIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:16:18 INFO - Running setup.py (path:/tmp/pip-2SXNIG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:16:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:18 INFO - Running setup.py install for manifestparser 09:16:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Running setup.py install for mozcrash 09:16:19 INFO - Running setup.py install for mozdebug 09:16:19 INFO - Running setup.py install for mozdevice 09:16:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Running setup.py install for mozfile 09:16:19 INFO - Running setup.py install for mozhttpd 09:16:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Running setup.py install for mozinfo 09:16:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Running setup.py install for mozInstall 09:16:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Running setup.py install for mozleak 09:16:19 INFO - Running setup.py install for mozlog 09:16:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:16:19 INFO - Running setup.py install for moznetwork 09:16:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:16:20 INFO - Running setup.py install for mozprocess 09:16:20 INFO - Running setup.py install for mozprofile 09:16:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:16:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:16:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:16:20 INFO - Running setup.py install for mozrunner 09:16:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:16:20 INFO - Running setup.py install for mozscreenshot 09:16:20 INFO - Running setup.py install for moztest 09:16:20 INFO - Running setup.py install for mozversion 09:16:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:16:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:20 INFO - Cleaning up... 09:16:20 INFO - Return code: 0 09:16:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:16:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:20 INFO - Using env: {'DISPLAY': ':0', 09:16:20 INFO - 'HOME': '/home/cltbld', 09:16:20 INFO - 'LANG': 'en_US.UTF-8', 09:16:20 INFO - 'LANGUAGE': 'en_US:en', 09:16:20 INFO - 'LOGNAME': 'cltbld', 09:16:20 INFO - 'MAIL': '/var/mail/cltbld', 09:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:20 INFO - 'MOZ_NO_REMOTE': '1', 09:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:20 INFO - 'NO_EM_RESTART': '1', 09:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:20 INFO - 'SHELL': '/bin/bash', 09:16:20 INFO - 'SHLVL': '1', 09:16:20 INFO - 'TERM': 'linux', 09:16:20 INFO - 'TMOUT': '86400', 09:16:20 INFO - 'USER': 'cltbld', 09:16:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:20 INFO - '_': '/tools/buildbot/bin/python'} 09:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:16:20 INFO - Running setup.py (path:/tmp/pip-2jMfnA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:16:20 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)) 09:16:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:16:20 INFO - Running setup.py (path:/tmp/pip-BhOCAb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:16:21 INFO - Running setup.py (path:/tmp/pip-Vupy3p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:16:21 INFO - Running setup.py (path:/tmp/pip-B4gT9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:16:21 INFO - Running setup.py (path:/tmp/pip-C7Zym2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:16:21 INFO - Running setup.py (path:/tmp/pip-LThCxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:16:21 INFO - Running setup.py (path:/tmp/pip-m1ApI1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:16:21 INFO - Running setup.py (path:/tmp/pip-WABHC4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:16:21 INFO - Running setup.py (path:/tmp/pip-rBDBrO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:16:21 INFO - Running setup.py (path:/tmp/pip-H5l1dt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:16:21 INFO - Running setup.py (path:/tmp/pip-aBI2F1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:16:21 INFO - Running setup.py (path:/tmp/pip-Wm2a5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:16:21 INFO - Running setup.py (path:/tmp/pip-CpbC23-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:16:21 INFO - Running setup.py (path:/tmp/pip-iYtEGe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:16:21 INFO - Running setup.py (path:/tmp/pip-QH6bvT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:16:21 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)) 09:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:16:21 INFO - Running setup.py (path:/tmp/pip-4xS_2A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:16:22 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)) 09:16:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:16:22 INFO - Running setup.py (path:/tmp/pip-4GG6Y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:16:22 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)) 09:16:22 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:22 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:22 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)) 09:16:22 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)) 09:16:22 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)) 09:16:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:22 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 09:16:22 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 09:16:22 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 09:16:22 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 09:16:22 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 09:16:22 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 09:16:23 INFO - Downloading blessings-1.6.tar.gz 09:16:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:24 INFO - Installing collected packages: blessings 09:16:24 INFO - Running setup.py install for blessings 09:16:24 INFO - Successfully installed blessings 09:16:24 INFO - Cleaning up... 09:16:24 INFO - Return code: 0 09:16:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:16:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:16:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:16:24 INFO - Reading from file tmpfile_stdout 09:16:24 INFO - Current package versions: 09:16:24 INFO - argparse == 1.2.1 09:16:24 INFO - blessings == 1.6 09:16:24 INFO - blobuploader == 1.2.4 09:16:24 INFO - docopt == 0.6.1 09:16:24 INFO - manifestparser == 1.1 09:16:24 INFO - mozInstall == 1.12 09:16:24 INFO - mozcrash == 0.17 09:16:24 INFO - mozdebug == 0.1 09:16:24 INFO - mozdevice == 0.48 09:16:24 INFO - mozfile == 1.2 09:16:24 INFO - mozhttpd == 0.7 09:16:24 INFO - mozinfo == 0.9 09:16:24 INFO - mozleak == 0.1 09:16:24 INFO - mozlog == 3.1 09:16:24 INFO - moznetwork == 0.27 09:16:24 INFO - mozprocess == 0.22 09:16:24 INFO - mozprofile == 0.28 09:16:24 INFO - mozrunner == 6.11 09:16:24 INFO - mozscreenshot == 0.1 09:16:24 INFO - mozsystemmonitor == 0.0 09:16:24 INFO - moztest == 0.7 09:16:24 INFO - mozversion == 1.4 09:16:24 INFO - psutil == 3.1.1 09:16:24 INFO - requests == 1.2.3 09:16:24 INFO - wsgiref == 0.1.2 09:16:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:16: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')]} 09:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:16:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:24 INFO - Using env: {'DISPLAY': ':0', 09:16:24 INFO - 'HOME': '/home/cltbld', 09:16:24 INFO - 'LANG': 'en_US.UTF-8', 09:16:24 INFO - 'LANGUAGE': 'en_US:en', 09:16:24 INFO - 'LOGNAME': 'cltbld', 09:16:24 INFO - 'MAIL': '/var/mail/cltbld', 09:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:24 INFO - 'MOZ_NO_REMOTE': '1', 09:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:24 INFO - 'NO_EM_RESTART': '1', 09:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:24 INFO - 'SHELL': '/bin/bash', 09:16:24 INFO - 'SHLVL': '1', 09:16:24 INFO - 'TERM': 'linux', 09:16:24 INFO - 'TMOUT': '86400', 09:16:24 INFO - 'USER': 'cltbld', 09:16:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:24 INFO - '_': '/tools/buildbot/bin/python'} 09:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 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)) 09:16:24 INFO - Cleaning up... 09:16:24 INFO - Return code: 0 09:16:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:16: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')]} 09:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:16:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:24 INFO - Using env: {'DISPLAY': ':0', 09:16:24 INFO - 'HOME': '/home/cltbld', 09:16:24 INFO - 'LANG': 'en_US.UTF-8', 09:16:24 INFO - 'LANGUAGE': 'en_US:en', 09:16:24 INFO - 'LOGNAME': 'cltbld', 09:16:24 INFO - 'MAIL': '/var/mail/cltbld', 09:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:24 INFO - 'MOZ_NO_REMOTE': '1', 09:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:24 INFO - 'NO_EM_RESTART': '1', 09:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:24 INFO - 'SHELL': '/bin/bash', 09:16:24 INFO - 'SHLVL': '1', 09:16:24 INFO - 'TERM': 'linux', 09:16:24 INFO - 'TMOUT': '86400', 09:16:24 INFO - 'USER': 'cltbld', 09:16:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:24 INFO - '_': '/tools/buildbot/bin/python'} 09:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:24 INFO - Downloading/unpacking jsonschema 09:16:24 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 09:16:24 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 09:16:24 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 09:16:24 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 09:16:24 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 09:16:24 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 09:16:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:26 INFO - Downloading/unpacking functools32 (from jsonschema) 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:26 INFO - warning: no files found matching '*.txt' 09:16:26 INFO - no previously-included directories found matching 'build' 09:16:26 INFO - no previously-included directories found matching 'dist' 09:16:26 INFO - no previously-included directories found matching '.git*' 09:16:27 INFO - Installing collected packages: jsonschema, functools32 09:16:27 INFO - Running setup.py install for functools32 09:16:27 INFO - warning: no files found matching '*.txt' 09:16:27 INFO - no previously-included directories found matching 'build' 09:16:27 INFO - no previously-included directories found matching 'dist' 09:16:27 INFO - no previously-included directories found matching '.git*' 09:16:27 INFO - Successfully installed jsonschema functools32 09:16:27 INFO - Cleaning up... 09:16:27 INFO - Return code: 0 09:16:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69234dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a836b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, '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': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', '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 09:16:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:16:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:16:27 INFO - Using env: {'DISPLAY': ':0', 09:16:27 INFO - 'HOME': '/home/cltbld', 09:16:27 INFO - 'LANG': 'en_US.UTF-8', 09:16:27 INFO - 'LANGUAGE': 'en_US:en', 09:16:27 INFO - 'LOGNAME': 'cltbld', 09:16:27 INFO - 'MAIL': '/var/mail/cltbld', 09:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:27 INFO - 'MOZ_NO_REMOTE': '1', 09:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:27 INFO - 'NO_EM_RESTART': '1', 09:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:27 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:27 INFO - 'SHELL': '/bin/bash', 09:16:27 INFO - 'SHLVL': '1', 09:16:27 INFO - 'TERM': 'linux', 09:16:27 INFO - 'TMOUT': '86400', 09:16:27 INFO - 'USER': 'cltbld', 09:16:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:27 INFO - '_': '/tools/buildbot/bin/python'} 09:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:27 INFO - Downloading/unpacking flake8 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:16:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:16:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:16:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:29 INFO - no previously-included directories found matching 'docs/_build' 09:16:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:16:30 INFO - Running setup.py install for pep8 09:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:30 INFO - no previously-included directories found matching 'docs/_build' 09:16:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:16:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:16:30 INFO - Cleaning up... 09:16:30 INFO - Return code: 0 09:16:30 INFO - Running post-action listener: _resource_record_post_action 09:16:30 INFO - Running post-action listener: _start_resource_monitoring 09:16:30 INFO - Starting resource monitoring. 09:16:30 INFO - ##### 09:16:30 INFO - ##### Running install step. 09:16:30 INFO - ##### 09:16:30 INFO - Running pre-action listener: _resource_record_pre_action 09:16:30 INFO - Running main action method: install 09:16:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:16:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:16:30 INFO - Reading from file tmpfile_stdout 09:16:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:16:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:16:30 INFO - Reading from file tmpfile_stdout 09:16:30 INFO - Output received: 09:16:30 INFO - Usage: mozinstall [options] installer 09:16:30 INFO - Options: 09:16:30 INFO - -h, --help show this help message and exit 09:16:30 INFO - -d DEST, --destination=DEST 09:16:30 INFO - Directory to install application into. [default: 09:16:30 INFO - "/builds/slave/test-pgo"] 09:16:30 INFO - --app=APP Application being installed. [default: firefox] 09:16:30 INFO - mkdir: /builds/slave/test-pgo/build/application 09:16:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:16:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:16:46 INFO - Reading from file tmpfile_stdout 09:16:46 INFO - Output received: 09:16:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:16:46 INFO - Running post-action listener: _resource_record_post_action 09:16:46 INFO - ##### 09:16:46 INFO - ##### Running run-tests step. 09:16:46 INFO - ##### 09:16:46 INFO - Running pre-action listener: _resource_record_pre_action 09:16:46 INFO - Running main action method: run_tests 09:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:16:46 INFO - Python 2.7.3 09:16:46 INFO - Return code: 0 09:16:46 INFO - grabbing minidump binary from tooltool 09:16:46 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')]} 09:16:46 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 0x2a7e1d0>, '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 0x2a81750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a81be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:16:46 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 09:16:46 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 09:16:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:46 INFO - Return code: 0 09:16:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:16:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:16:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:16:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:16:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:16:47 INFO - Return code: 0 09:16:47 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 09:16:47 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 09:16:47 INFO - Using env: {'DISPLAY': ':0', 09:16:47 INFO - 'HOME': '/home/cltbld', 09:16:47 INFO - 'LANG': 'en_US.UTF-8', 09:16:47 INFO - 'LANGUAGE': 'en_US:en', 09:16:47 INFO - 'LOGNAME': 'cltbld', 09:16:47 INFO - 'MAIL': '/var/mail/cltbld', 09:16:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:16:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:47 INFO - 'MOZ_NO_REMOTE': '1', 09:16:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:47 INFO - 'NO_EM_RESTART': '1', 09:16:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:16:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:16:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:16:47 INFO - 'SHELL': '/bin/bash', 09:16:47 INFO - 'SHLVL': '1', 09:16:47 INFO - 'TERM': 'linux', 09:16:47 INFO - 'TMOUT': '86400', 09:16:47 INFO - 'USER': 'cltbld', 09:16:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1458317754.794334-204258561', 09:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:47 INFO - '_': '/tools/buildbot/bin/python'} 09:16:47 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:16:48 INFO - mozversion application_buildid: 20160318053015 09:16:48 INFO - mozversion application_changeset: 571fa014bb35a2026fef866abe08daa52e599a46 09:16:48 INFO - mozversion application_display_name: Nightly 09:16:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:48 INFO - mozversion application_name: Firefox 09:16:48 INFO - mozversion application_remotingname: firefox 09:16:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:16:48 INFO - mozversion application_vendor: Mozilla 09:16:48 INFO - mozversion application_version: 48.0a1 09:16:48 INFO - mozversion platform_buildid: 20160318053015 09:16:48 INFO - mozversion platform_changeset: 571fa014bb35a2026fef866abe08daa52e599a46 09:16:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:16:48 INFO - mozversion platform_version: 48.0a1 09:16:48 INFO - using testdate: 1458317808 09:16:48 INFO - actual date: 1458317808 09:16:48 INFO - starting webserver on 'localhost:42864' 09:16:48 INFO - SUITE-START | Running 2 tests 09:16:48 INFO - TEST-START | dromaeo_css 09:16:48 INFO - operating with platform_type : linux_ 09:16:48 INFO - Initialising browser for dromaeo_css test... 09:16:48 INFO - TEST-INFO | started process 11954 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp75ye5X/profile http://localhost:42864/getInfo.html) 09:16:52 INFO - PROCESS | 11954 | __metrics Screen width/height:1600/1200 09:16:52 INFO - PROCESS | 11954 | colorDepth:24 09:16:52 INFO - PROCESS | 11954 | Browser inner width/height: 1024/697 09:16:52 INFO - PROCESS | 11954 | __metrics 09:16:53 ERROR - PROCESS | 11954 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:16:54 INFO - TEST-INFO | 11954: exit 0 09:16:54 INFO - Browser initialized. 09:16:54 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:54 INFO - TEST-INFO | started process 12050 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp75ye5X/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:06 INFO - PROCESS | 12050 | RSS: Main: 152952832 09:17:06 INFO - PROCESS | 12050 | 09:17:57 INFO - PROCESS | 12050 | 1458317877088 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] 09:20:04 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:42864/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42864/tests/dromaeo/cssquery-ext.html) 09:20:05 INFO - PROCESS | 12050 | RSS: Main: 250785792 09:20:05 INFO - PROCESS | 12050 | 09:23:07 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:42864/tests/dromaeo/cssquery-ext.html (next: http://localhost:42864/tests/dromaeo/cssquery-jquery.html) 09:23:08 INFO - PROCESS | 12050 | RSS: Main: 235364352 09:23:08 INFO - PROCESS | 12050 | 09:26:10 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:42864/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42864/tests/dromaeo/cssquery-mootools.html) 09:26:11 INFO - PROCESS | 12050 | RSS: Main: 234815488 09:26:11 INFO - PROCESS | 12050 | 09:29:12 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:42864/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42864/tests/dromaeo/cssquery-prototype.html) 09:29:13 INFO - PROCESS | 12050 | RSS: Main: 221937664 09:29:13 INFO - PROCESS | 12050 | 09:32:15 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:42864/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42864/tests/dromaeo/cssquery-yui.html) 09:32:16 INFO - PROCESS | 12050 | RSS: Main: 223965184 09:32:16 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | Cycle 1(1): loaded http://localhost:42864/tests/dromaeo/cssquery-yui.html (next: http://localhost:42864/tests/dromaeo/cssquery-dojo.html) 09:35:19 INFO - PROCESS | 12050 | RSS: Main: 267431936 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | __start_tp_report 09:35:19 INFO - PROCESS | 12050 | _x_x_mozilla_page_load 09:35:19 INFO - PROCESS | 12050 | _x_x_mozilla_page_load_details 09:35:19 INFO - PROCESS | 12050 | |i|pagename|runs| 09:35:19 INFO - PROCESS | 12050 | |0;dojo.html;3072.554479600458;3109.751219902408;3130.123565401688;3159.5892533970596;3163.6994485523874;5228.4771522847695;5289.629725919187;5300.734963251836;5302.893942121155;5331.626786124973;5347.786088556462;5379.1662292344745;5394.946050539494;5411.404745478004;5451.809186678467;4797.9760101199445;4818.734969576672;4823.1800593899125;4826.058918510892;4939.67892087015;4888.97555512222;4893.535114164149;4926.359573255471;4964.056829202458;4970.453250142481;4672.322513235579;4809.062232864593;4848.927266091011;4890.14422476067;4892.094962431962;4815.614750819926;4835.564799168092;4844.903101937976;4845.103655823648;4861.854144375674;4693.48371679115;4798.0643774464;4808.567228949411;4820.831270905536;4852.102361063179;5246.055709972204;5305.230741542493;5315.521603055705;5319.175527793198;5341.385740639837;5735.225744524478;5740.282464691913;5759.049756790125;5768.567357448208;5775.075987841967;5616.269884914935;5711.05767548354;5743.54051675865;5757.712114394305;5766.942330576682;5345.3852806926925;5359.276497672803;5380.166074258496;5407.486288802557;5409.513143817076;5868.706564671749;5873.735681894325;5874.882502350015;5875.970620146957;5879.412058794172;5510.641808282448;5645.633033852787;5658.405867383948;5688.914666280009;5745.425457454305;5765.221695071112;5774.133879917962;5774.162746401748;5788.450097240755;5805.680687562224;5711.828645140652;5735.913961290584;5761.798337058183;5763.481286684135;5765.538756899438;5558.916616250759;5726.685032323262;5728.398518155534;5806.390329015477;5839.766409343663;4396.538363471854;4398.252297109435;4399.912001760011;4401.2517871961845;4433.534478879671;3891.922161556753;3915.4322623219473;3931.9606803932165;3967.821448034845;3977.1449138434796;5255.264263003182;5382;5435.211894275308;5444.782208711607;5448.45515448452;5775.48020678141;5783.0457974434585;5786.826395208151;5791.942080579224;5799.18811366409;5405.162199859028;5407.297051383295;5411.485908838654;5412.810551630674;5418.106012507892;4800.927986080212;4935.358403407534;4940.925886111711;5006.64953453262;5026.472220416877;5906.379830117861;5955.821325360246;5960.37416071315;5963.701814909237;5965.075413310944;5738.311402631544;5744;5750.712464376681;5751.166080918327;5768.134779783066;5781.537477001746;5945.435183657545;5981.700914954322;6000.549958753199;6038.275406951194;5630.88738225225;5652.3217213934595;5670.121131224667;5670.631408958405;5670.886582268414;5542.0855558832345;5746.195532625519;5750.6262092963825;5752.741126649395;5761.193432919478;5615.691136987505;5642.069058605448;5665;5692.345380281155;5708.600397972102;5592.468715472024;5620.803271885465;5624.015797235549;5626.071698169756;5626.409227031103;5355.625106242525;5511.255980442589;5529.668219906657;5532.529734972572;5537.418571050143;5629.54963602919;5639.7744090237575;5654.038813401649;5654.575906807088;5712.171735098471;5489.3687225969525;5514.310711161105;5519.448055194609;5528.19841123043;5561.749721262472 09:35:19 INFO - PROCESS | 12050 | |1;ext.html;558.820312422317;573.6902072880645;585.3356440440101;600.9969950150248;617.6726335042426;30874.38251234974;42721.57278427219;43094.784526077405;43190.136197276035;43231.78384108079;46208.768956155174;47030;47085.764571177184;47152.29271560929;47173.764131179385;7892.644830982619;8643.481391116553;8857.379983401164;10060.496975151249;10226.181905447545;10213.438260895648;10339.793204135913;10348.689539313833;10351.637692680757;10351.689449316495;10340.379577225352;10431.634892778755;10434.634787782428;10435.269531132824;10440.791184176313;10241.539130739098;10321.43232122233;10331.999999999962;10337.22470814692;10351.482425878714;10370.429626370547;10517.84223236652;10534.841977370346;10536;10539;43003.569964300266;43051.569484305066;43154.56845431568;43201.599800025;43509.782451087856;3400.370931377703;3555.288942211568;3666.138457462494;3945.151792364655;3956.8812935611977;32875.835620821985;33058;33398.666013339796;33784;33827.32345353079;4182.142660754538;4306.35404689296;4317.892052698708;4375.409319741858;4391.802368893375;246417;247959.76020119965;248047;249575;250643;63852.36147638557;64330.678346608904;64346.67826660837;64374;64440.67779661166;75404;76581.61709191419;76854.61572692213;76877.6156119227;76886;16004.199790010685;16300.755488667679;16421;16438.671226575403;16440.83559164417;12243.326617035971;12379.504819807107;12387.814182787266;12391.318477483645;12392;21878.671819922394;22154.335369938926;22203.444913877283;22214.777852221272;22264.332070037926;8136.227058429558;8390.286825619769;8456.238938495564;8468.788280293042;8524.275436587835;1070.3249414666022;1084.9945750271197;1086.4567716141928;1097.3470784882982;1171.8828117188384;32950;32998.67001329956;33279.833600831844;33348;34071.148221294665;1050.3435352904435;1094.63876920616;1113.693734223079;1149.5516748468103;1152.608113241502;14996.775048374284;15004.24978751058;15034.69930601382;15070.698586028218;15302.158381289137;316303;318796;319485;319512;319970;52520.47479525156;52831;52996;53093.73453132709;53135.46864531305;1190.892819646236;1289.4842063174617;1345.387848528917;1375.326090215787;1386.9930650346685;28937.13188604345;29863.402731944803;30274.24314392158;30291.242718932204;30588.847055764578;42388.576114238465;42533.57466425296;43027;43046.35430468483;43112;205897;206006;206244;206854;207641;31677.20806979844;36136.63863361333;36731;37023.44464832976;37055.814720926224;42957.785211073744;43049.354259686756;43068.138637227705;43387.56612433962;43477.347839781796;37256.254874902894;38207.235855283296;39051;39232.2153556933;39354.803225983684;37734.43398348972;38130.809345953094;38188.28152733078;38509;38865;38695.22609547737;39978.80010599928;40462.59537404706;40724;40732.38901416422;33997.49003764995;36734.265314693024;36979.44530832094;37220.62779372172;37246.25507489781;26022;26252.606210907234;26255.868720656275;26279.868600656875;26619.46761064729 09:35:19 INFO - PROCESS | 12050 | |2;jquery.html;373.9663430291273;376.78899816102984;382.3251960290087;385.731916318159;389.1108816354629;17833.821661783393;18033;18739.250429982818;18771.90614046928;18790.718139227905;17693.91153044236;18315.17581708823;19114.904425477853;19126.808731912675;19148;5513.2005859150295;5631.63394379366;5656.2929633795775;5666.801661941833;5670.461306175927;4119.237940980913;5635.718214089299;5973.731182096794;6223.7510499580185;6240.812775616716;6206.503479721634;6221.0979407985815;6226.37736226376;6228.159198508189;6230.719617617196;5875.7062146892695;6082.452579267887;6086.056661217518;6095.329513753483;6096.146539484475;3705.073731567108;5292.470752924715;5394;5521.199426083235;5523.4200408956885;20768.896155519276;20843.478913027146;20882.686759698616;22459.32622021342;22495;2377.3511923948577;2380.4643955110137;2386.129062892032;2424.175780234729;2444.99755100408;13870.653233669138;13906.443742250298;13939.581812545639;14145.080569762933;14527.70944581113;1954.99022504888;1994.8813586223282;2009.1862795567818;2017.213286818142;2034.0541648133542;69499.65250173716;71885.2811471889;72396.27603724001;72438.63780681063;72891.63554182195;10503.52734126966;10516.421596812248;10936.945315273373;10991.670249892515;11155.386453744959;14123.364448599837;14258.358373873201;14262.072965257224;14269.143851368952;14274.714505709828;7961;8151.836963260702;8163.142869998684;8230.8353832923;8287.875681864776;7432.777016689508;7531.209223031503;7896.692586625645;7951.363890888715;8036.557989310527;6587.422473095766;6736.730530778714;6767.458603311723;6776.356246156607;6858.417034552119;1698.3036954848453;1821.253286152671;1882.4917272336393;1885.1611033090417;1890.5084677983823;429.5554101504927;432.4507874998797;953.9189168920719;1046.3109807793896;1121.2711737370773;10829.458527073615;11371.54513819438;11420.14348923834;11481.71295717597;11612.187146899805;454.94768101668734;459.010831657778;460.1625042422758;463.3767582601396;475.14948242645966;6142.355052719489;6214.316425193225;6260.780872669526;6371.872562548723;6379.744810207632;517952;530435;531805;531813;543045;79734.20265797384;79891;80710.5964470174;80929.59535202404;85707;480.224437533388;481.8265424447266;483.8137317132859;484.70433035848106;485.65761138397346;10520.947395262974;10838.241323107306;10856.565737370416;10906.509207085859;11020.283681560673;35713.46429803607;36608.35262413145;36687.63312366949;36688.81655591705;36773.26453470969;50723.23915141202;54909;55061.72469137629;55161;55732.16401754058;8200.138985406445;8261.83476330482;8331.250187483156;8399.496030238206;8532.488050716976;9395.201407880406;12165.513379464723;12264.141510094565;12675.873241267469;12705.872941270469;6554.4756419485375;7481.625918704151;11214.719632009264;11377.374244416636;11605.245659032136;10711.464426778473;10868.945655271673;10989.120870330515;11151.163662725166;11156.944215279196;11419.143564232882;11444.82832757526;11571.537138514364;11587.942060289644;11641.6507504775;8043.235892590194;8121.79695507617;8129.715459958873;8217.876731848908;8416.11630778784;9796.363236389612;11073.723156921142;11132;11223;11250.83123753128 09:35:19 INFO - PROCESS | 12050 | |3;mootools.html;1286.6075846866702;1514.1066770605341;1525.2907398059904;1708.0947098038037;1840.2179073893592;7986.201379862011;8163.632636531355;8170.305524030449;8170.877436838452;8175.264226219639;7901.209879012096;8052.63763130659;8068.757937261891;8072.757817265477;8076.676932922691;2044.5297581556251;2337.076854642415;2378.916737914173;2383.84505007174;2402.6876506054186;2377;2388.355144111089;2389.2593296078185;2392.605220138675;2394.844335118212;2296.0930432479163;2358.917437889674;2361.669366288721;2365.231299827563;2365.3495288795634;2318.9072437102495;2328.1502251678185;2358.516504116652;2359.728631207416;2367.8460900041528;2358.740538540759;2391.246757271454;2397.3167647220457;2405.230326295586;2408.0608562660577;8285.047219569766;8302.875456868152;8325.333973282184;8328.958355208246;8353.122922093153;5143.485651434864;5230.3985041719925;5260.473952604747;5264.078786212436;5268.473152684739;3433.364827506919;3558.5729712434413;3569.411047177213;3585.8386372613295;3636.8727094551564;1167.486306025346;1178.2930241854904;1184.5025089462447;1215.7143071378218;1268.543324403214;11587.594434194847;11703;11735.706607334885;11741.178117531776;11744.29534227949;4651.302304654261;4692.1554120258;4770.332153498513;4775.856724298207;4778.04439112179;9878.851817222747;9919.603215871284;9936.602535898483;9948.353357031914;9960.551775170135;4526.366308716782;5241.50205730455;5244.606654500928;5245.423003469616;5245.947540524546;4642.814287428532;4663.860084197479;4703.905921881543;4719.646026548023;4725.4565724941385;4007.779572123561;4038.919221615551;4057.9391309130388;4075.5109386873764;4091;1285.575759999198;1303.1529505821293;1304.6281809684194;1304.9673758155932;1309.0574786153954;1384.2386687321932;1395.6301580081285;1398.7692030815006;1406.6694326833185;1414.9504767333094;7863.0957439894;7962.56205908669;8008.599570021475;8023.237792409712;8023.558704271204;507.1631807517625;509.55923126496054;513.1481740311066;514.9176131818891;518.0700642346997;6187.969060154761;6204.100405441186;6216.782412615627;6260.655663938436;6274.560780745304;9371;9598;9608.95195524018;9643.614255429844;9761.170300524393;9512;9619.807603847883;9636.42181469114;9646.807063858683;9683.83793944717;7928.048634163937;8010.959945200353;8012.679492820338;8080.39397045224;8102.068262149928;7899.052113746157;7911.762647120596;7989.081255655442;7997.400194985516;8032.598370081356;9017.594208260512;9244.399114057565;9278.860817087614;9351.579178936829;9542.141207291377;9349.813003740022;9385.48379839088;9569.234461242944;9628.614855405705;9779.168770654574;6619.437347825488;6796.72813087471;7232.819179520554;7394.704211831467;7482.70069197226;7947.5231486108705;7962.163972783006;7963.601819909098;7994.680212791656;8003.399745019264;7043.647817608997;7069.929300706927;7127.786166415016;7282.854342913218;7309.378702810321;7030.894536581853;7045.894311585228;7053.858922821412;7117.252688467636;7147.356737893615;7169.641517924188;7170.067891174114;7187.02975098355;7192.568445893263;7198.6040767756185;6922.757703480354;6926.168859736864;6981.371676549135;6997.405220556309;7003.509754317149;6980.895286570807;6991.930080699128;6993.4055605274125;7013.368796808311;7122.145342558926 09:35:19 INFO - PROCESS | 12050 | |4;prototype.html;341.74369223082687;344.1413672886148;344.29763282902877;344.9844756985936;351.6079571278024;6008.098785182225;6031.035034394497;6065.545084118687;6084.604500707456;6097.237845269336;5971.343152253248;5973.761049558012;5977.432143946329;5985.371535988724;5986.910196347058;4355.34669799531;4495.617872480843;4547.909041819162;4582.702124361923;4585.72485650862;4582.1293954148605;4583.610393116589;4592.540745925414;4601;4602.815887364502;4534.6372290216705;4539.523350048247;4543.1140927519145;4544.227481328182;4552.613027892633;4334.674899382543;4495.5729205725565;4562.5665561771575;4586.885327866797;4590.678652494294;4004.199160167949;4011.2378648056774;4015.4980627421573;4022.35642297231;4045.615666511677;5776.884462310731;5785.47930686236;5802.303723553201;5813.302403711539;5821.3014438267255;5419.458054194549;5427.674339539641;5427.782888684448;5428.212909128194;5432.75552600134;6373.107764912916;6387.68061596923;6388.64862432566;6394.328595497453;6405.29541750407;4374.4531933508315;4488.910221795546;4513.977430112861;4522.5025247222775;4523.84166554169;6649.966750166266;6707.128073350482;6732.29310922351;6733.663316834139;6737.258901520878;4685.0629874025335;4685.226937555265;4686.156491831435;4686.437627484655;4692.788824502837;4753.881152971203;4756.952430475721;4757.6193904488255;4759.571638552547;4761.642876784255;5422.48486393792;5424.1321388577635;5435.701036442954;5444.047291723932;5445;6334.271558770801;6465.450436712838;6475.449586785082;6497.902531462032;6505.544611877218;1657.4696097249005;1666.5916850371736;1674.2800595743947;1677.0189439178218;1677.429673910876;1046.858674079005;1124.6063877642923;1126.9267497612793;1162.8953394194564;1165.7901577716093;6070.2108725865355;6071.605345652519;6072.787452439232;6078.270607527125;6082.726277317532;6503.219613646393;6511.38141876521;6526.118973938457;6529.738810447624;6545.181852268466;6074.51403887688;6078.483328917003;6079.726412311456;6085.665288409092;6087.269527656621;3492.5285086513504;3530.0998245447245;3530.646935306449;3532.3288575170636;3535.151563624763;6722.798316050428;6785.694643741043;6980.965095174492;6995.8600827983155;6997.440204783605;6774;6845.452363810883;6854.760083397157;6854.862902741917;6856.4514838813775;6957.060796792368;6958.130233720785;6969.6515174241085;6969.815131427771;6971.3028697129885;6594.340565943559;6633.1045308882685;6670.699818508082;6695.129633147854;6702.296258892941;6466;6607.174103236903;6617.569857959217;6618.139641846529;6623.834404139935;6924.3421874921805;6958.095447591781;6961.199462061928;6963.199232088172;6963.2340442552295;4564.863054108382;4602.907941841211;4606.769661516978;4608.262677971643;4611.769411529343;6655.966720166562;6661.267260601427;6664;6665.100211471389;6665.866682666223;6354.555181137276;6502.837429064122;6508.414242718178;6510;6516.250631177475;6439.323870993666;6469.805905822833;6472.514561407819;6479.514036447191;6490.123833282635;6319.6208227506495;6347.619142851444;6352.301246862749;6358.1734374531015;6364.459020983269;6510.707018184098;6512.869742605216;6517.087607735016;6519;6556;5887.712217247657;6135.171751813448;6195.504359651307;6344.936550634619;6365.745370185326 09:35:19 INFO - PROCESS | 12050 | |5;yui.html;753.0624372656042;783.6512751825436;878.7671267114216;885.7475619448459;886.6010295367087;14394.352254148562;14567.344469498872;14637.92681036596;14677.486287979922;14684.70630587389;14355.928220358883;14439.639009024753;14455.421783128662;14547.199904005276;14574.635634109127;691.9481038922075;827.6606591297555;828.0477450931447;845.6363763581688;848.1560846957286;834.1741675741004;834.6369329341726;835.2691395029349;836.3810780022769;837.3677873205721;893.5532233883058;896.8430524658191;897.0356866368647;897.0491279244022;897.0670502677208;723.6924307169459;878.3324673248345;886.5965985476593;889.9822003559957;890.1765866573459;644.0661041489858;644.1979735229622;644.622895606071;644.9226092868839;645.3578689204224;14885.181315027668;14970.326335314829;14970.925145374204;14995.775063374058;15023.549293521211;13697.520586779514;13997.160170389809;14000.439982400692;14003.369848356848;14592.124472531576;11398.772024559545;11623.418829058597;11719.648410547697;11723.648290551297;11837.585684501;3785.886423407302;3787.4886890269736;3866.1107945172485;3886.5336159660737;3927.8232479538206;54657.90684186334;55004;55161;55192.44807551953;55199.44800551983;10471.790564188674;10522.368657880552;10628.309159904582;10657.360558366523;10709.892901070889;18932.71600925987;18957.146928388254;19115.71326430105;19119.617607647768;19133.904330478257;7908.446408751447;7926.682932682628;7944.404169687181;8017.599120044091;8150.7147249845975;4478.081993191388;4544.159330523864;4620.4686461056735;4621.4223222097235;4703.294505824154;3286.901392958215;3316.3035762489667;3317.419451595961;3326.6507016763376;3329.8002119872885;567.821136342051;629.4555209743539;646.873859597374;690.6339639990813;704.0987535953988;625.5808608232495;625.9296602809247;682.9419499342512;707.678006507038;776.9184235655288;9233.215176710055;9245.306602004743;9256.629734810667;9342.532873356306;9360.719178424659;645.554567348528;661.9007148927699;662.5461558832216;701.8806802843427;710.3713213805819;4105.630493255561;4212.515560710496;4218.282891908383;4270.145970805851;4438.35643831649;62989.68505157445;63439.68280158662;63648;64017.35982640114;64301;56956;57306;57364.139537906965;57947.71026144927;58523.70738146282;50484.49515504872;51028.23457648212;51729;52942.47057529375;53082.73458632682;8750.606222719865;8774.868376974478;8901.243394311556;8965.596548155218;9426.293028023063;37875;38162;38614;39102.21795564016;39740.602593973694;44688.77655611701;48252.416020478;49065.754671226416;49456.75271623619;51860.222096669335;10839.078678312117;11251.831222531504;11646.94176529112;11759.353235572125;11768.176227664324;12861;12941.482340706267;13004.869951300745;13716.65708357259;13764.65588360299;11001.944990274997;12034.63896083119;12257.325847078497;12791.424385902843;12822.807657884952;12519.749605008032;12730.554430594884;12749.298788566717;12987.675308117372;13367.799483007568;12463.189892656948;12760.936195318964;12876.935615321863;13539.458421663023;13722.245276509888;10512.211584131373;10810.567577297135;10826.837597436202;10879.184061195283;11012.17408694335;11040.503177356877;11118.166137539554;11119.388433636228;11122.721931951766;11232.382218978035 09:35:19 INFO - PROCESS | 12050 | __end_tp_report 09:35:19 INFO - PROCESS | 12050 | __start_cc_report 09:35:19 INFO - PROCESS | 12050 | _x_x_mozilla_cycle_collect,735 09:35:19 INFO - PROCESS | 12050 | __end_cc_report 09:35:19 INFO - PROCESS | 12050 | __startTimestamp1458318919251__endTimestamp 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | ------- Summary: start ------- 09:35:19 INFO - PROCESS | 12050 | Number of tests: 6 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | [#0] dojo.html Cycles:165 Average:5328.52 Median:5529.67 stddev:607.89 (11.0%) stddev-sans-first:583.42 09:35:19 INFO - PROCESS | 12050 | Values: 3072.6 3109.8 3130.1 3159.6 3163.7 5228.5 5289.6 5300.7 5302.9 5331.6 5347.8 5379.2 5394.9 5411.4 5451.8 4798.0 4818.7 4823.2 4826.1 4939.7 4889.0 4893.5 4926.4 4964.1 4970.5 4672.3 4809.1 4848.9 4890.1 4892.1 4815.6 4835.6 4844.9 4845.1 4861.9 4693.5 4798.1 4808.6 4820.8 4852.1 5246.1 5305.2 5315.5 5319.2 5341.4 5735.2 5740.3 5759.0 5768.6 5775.1 5616.3 5711.1 5743.5 5757.7 5766.9 5345.4 5359.3 5380.2 5407.5 5409.5 5868.7 5873.7 5874.9 5876.0 5879.4 5510.6 5645.6 5658.4 5688.9 5745.4 5765.2 5774.1 5774.2 5788.5 5805.7 5711.8 5735.9 5761.8 5763.5 5765.5 5558.9 5726.7 5728.4 5806.4 5839.8 4396.5 4398.3 4399.9 4401.3 4433.5 3891.9 3915.4 3932.0 3967.8 3977.1 5255.3 5382.0 5435.2 5444.8 5448.5 5775.5 5783.0 5786.8 5791.9 5799.2 5405.2 5407.3 5411.5 5412.8 5418.1 4800.9 4935.4 4940.9 5006.6 5026.5 5906.4 5955.8 5960.4 5963.7 5965.1 5738.3 5744.0 5750.7 5751.2 5768.1 5781.5 5945.4 5981.7 6000.5 6038.3 5630.9 5652.3 5670.1 5670.6 5670.9 5542.1 5746.2 5750.6 5752.7 5761.2 5615.7 5642.1 5665.0 5692.3 5708.6 5592.5 5620.8 5624.0 5626.1 5626.4 5355.6 5511.3 5529.7 5532.5 5537.4 5629.5 5639.8 5654.0 5654.6 5712.2 5489.4 5514.3 5519.4 5528.2 5561.7 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | [#1] ext.html Cycles:180 Average:45378.61 Median:33591.33 stddev:68282.24 (203.3%) stddev-sans-first:68390.86 09:35:19 INFO - PROCESS | 12050 | Values: 558.8 573.7 585.3 601.0 617.7 30874.4 42721.6 43094.8 43190.1 43231.8 46208.8 47030.0 47085.8 47152.3 47173.8 7892.6 8643.5 8857.4 10060.5 10226.2 10213.4 10339.8 10348.7 10351.6 10351.7 10340.4 10431.6 10434.6 10435.3 10440.8 10241.5 10321.4 10332.0 10337.2 10351.5 10370.4 10517.8 10534.8 10536.0 10539.0 43003.6 43051.6 43154.6 43201.6 43509.8 3400.4 3555.3 3666.1 3945.2 3956.9 32875.8 33058.0 33398.7 33784.0 33827.3 4182.1 4306.4 4317.9 4375.4 4391.8 246417.0 247959.8 248047.0 249575.0 250643.0 63852.4 64330.7 64346.7 64374.0 64440.7 75404.0 76581.6 76854.6 76877.6 76886.0 16004.2 16300.8 16421.0 16438.7 16440.8 12243.3 12379.5 12387.8 12391.3 12392.0 21878.7 22154.3 22203.4 22214.8 22264.3 8136.2 8390.3 8456.2 8468.8 8524.3 1070.3 1085.0 1086.5 1097.3 1171.9 32950.0 32998.7 33279.8 33348.0 34071.1 1050.3 1094.6 1113.7 1149.6 1152.6 14996.8 15004.2 15034.7 15070.7 15302.2 316303.0 318796.0 319485.0 319512.0 319970.0 52520.5 52831.0 52996.0 53093.7 53135.5 1190.9 1289.5 1345.4 1375.3 1387.0 28937.1 29863.4 30274.2 30291.2 30588.8 42388.6 42533.6 43027.0 43046.4 43112.0 205897.0 206006.0 206244.0 206854.0 207641.0 31677.2 36136.6 36731.0 37023.4 37055.8 42957.8 43049.4 43068.1 43387.6 43477.3 37256.3 38207.2 39051.0 39232.2 39354.8 37734.4 38130.8 38188.3 38509.0 38865.0 38695.2 39978.8 40462.6 40724.0 40732.4 33997.5 36734.3 36979.4 37220.6 37246.3 26022.0 26252.6 26255.9 26279.9 26619.5 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | [#2] jquery.html Cycles:180 Average:28675.21 Median:431.00 stddev:87095.52 (20207.6%) stddev-sans-first:87313.92 09:35:19 INFO - PROCESS | 12050 | Values: 374.0 376.8 382.3 385.7 389.1 17833.8 18033.0 18739.3 18771.9 18790.7 17693.9 18315.2 19114.9 19126.8 19148.0 5513.2 5631.6 5656.3 5666.8 5670.5 4119.2 5635.7 5973.7 6223.8 6240.8 6206.5 6221.1 6226.4 6228.2 6230.7 5875.7 6082.5 6086.1 6095.3 6096.1 3705.1 5292.5 5394.0 5521.2 5523.4 20768.9 20843.5 20882.7 22459.3 22495.0 2377.4 2380.5 2386.1 2424.2 2445.0 13870.7 13906.4 13939.6 14145.1 14527.7 1955.0 1994.9 2009.2 2017.2 2034.1 69499.7 71885.3 72396.3 72438.6 72891.6 10503.5 10516.4 10936.9 10991.7 11155.4 14123.4 14258.4 14262.1 14269.1 14274.7 7961.0 8151.8 8163.1 8230.8 8287.9 7432.8 7531.2 7896.7 7951.4 8036.6 6587.4 6736.7 6767.5 6776.4 6858.4 1698.3 1821.3 1882.5 1885.2 1890.5 429.6 432.5 953.9 1046.3 1121.3 10829.5 11371.5 11420.1 11481.7 11612.2 454.9 459.0 460.2 463.4 475.1 6142.4 6214.3 6260.8 6371.9 6379.7 517952.0 530435.0 531805.0 531813.0 543045.0 79734.2 79891.0 80710.6 80929.6 85707.0 480.2 481.8 483.8 484.7 485.7 10520.9 10838.2 10856.6 10906.5 11020.3 35713.5 36608.4 36687.6 36688.8 36773.3 50723.2 54909.0 55061.7 55161.0 55732.2 8200.1 8261.8 8331.3 8399.5 8532.5 9395.2 12165.5 12264.1 12675.9 12705.9 6554.5 7481.6 11214.7 11377.4 11605.2 10711.5 10868.9 10989.1 11151.2 11156.9 11419.1 11444.8 11571.5 11587.9 11641.7 8043.2 8121.8 8129.7 8217.9 8416.1 9796.4 11073.7 11132.0 11223.0 11250.8 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | [#3] mootools.html Cycles:180 Average:5833.46 Median:6708.08 stddev:3038.45 (45.3%) stddev-sans-first:3027.74 09:35:19 INFO - PROCESS | 12050 | Values: 1286.6 1514.1 1525.3 1708.1 1840.2 7986.2 8163.6 8170.3 8170.9 8175.3 7901.2 8052.6 8068.8 8072.8 8076.7 2044.5 2337.1 2378.9 2383.8 2402.7 2377.0 2388.4 2389.3 2392.6 2394.8 2296.1 2358.9 2361.7 2365.2 2365.3 2318.9 2328.2 2358.5 2359.7 2367.8 2358.7 2391.2 2397.3 2405.2 2408.1 8285.0 8302.9 8325.3 8329.0 8353.1 5143.5 5230.4 5260.5 5264.1 5268.5 3433.4 3558.6 3569.4 3585.8 3636.9 1167.5 1178.3 1184.5 1215.7 1268.5 11587.6 11703.0 11735.7 11741.2 11744.3 4651.3 4692.2 4770.3 4775.9 4778.0 9878.9 9919.6 9936.6 9948.4 9960.6 4526.4 5241.5 5244.6 5245.4 5245.9 4642.8 4663.9 4703.9 4719.6 4725.5 4007.8 4038.9 4057.9 4075.5 4091.0 1285.6 1303.2 1304.6 1305.0 1309.1 1384.2 1395.6 1398.8 1406.7 1415.0 7863.1 7962.6 8008.6 8023.2 8023.6 507.2 509.6 513.1 514.9 518.1 6188.0 6204.1 6216.8 6260.7 6274.6 9371.0 9598.0 9609.0 9643.6 9761.2 9512.0 9619.8 9636.4 9646.8 9683.8 7928.0 8011.0 8012.7 8080.4 8102.1 7899.1 7911.8 7989.1 7997.4 8032.6 9017.6 9244.4 9278.9 9351.6 9542.1 9349.8 9385.5 9569.2 9628.6 9779.2 6619.4 6796.7 7232.8 7394.7 7482.7 7947.5 7962.2 7963.6 7994.7 8003.4 7043.6 7069.9 7127.8 7282.9 7309.4 7030.9 7045.9 7053.9 7117.3 7147.4 7169.6 7170.1 7187.0 7192.6 7198.6 6922.8 6926.2 6981.4 6997.4 7003.5 6980.9 6991.9 6993.4 7013.4 7122.1 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | [#4] prototype.html Cycles:180 Average:5385.51 Median:6072.20 stddev:1623.48 (26.7%) stddev-sans-first:1583.28 09:35:19 INFO - PROCESS | 12050 | Values: 341.7 344.1 344.3 345.0 351.6 6008.1 6031.0 6065.5 6084.6 6097.2 5971.3 5973.8 5977.4 5985.4 5986.9 4355.3 4495.6 4547.9 4582.7 4585.7 4582.1 4583.6 4592.5 4601.0 4602.8 4534.6 4539.5 4543.1 4544.2 4552.6 4334.7 4495.6 4562.6 4586.9 4590.7 4004.2 4011.2 4015.5 4022.4 4045.6 5776.9 5785.5 5802.3 5813.3 5821.3 5419.5 5427.7 5427.8 5428.2 5432.8 6373.1 6387.7 6388.6 6394.3 6405.3 4374.5 4488.9 4514.0 4522.5 4523.8 6650.0 6707.1 6732.3 6733.7 6737.3 4685.1 4685.2 4686.2 4686.4 4692.8 4753.9 4757.0 4757.6 4759.6 4761.6 5422.5 5424.1 5435.7 5444.0 5445.0 6334.3 6465.5 6475.4 6497.9 6505.5 1657.5 1666.6 1674.3 1677.0 1677.4 1046.9 1124.6 1126.9 1162.9 1165.8 6070.2 6071.6 6072.8 6078.3 6082.7 6503.2 6511.4 6526.1 6529.7 6545.2 6074.5 6078.5 6079.7 6085.7 6087.3 3492.5 3530.1 3530.6 3532.3 3535.2 6722.8 6785.7 6981.0 6995.9 6997.4 6774.0 6845.5 6854.8 6854.9 6856.5 6957.1 6958.1 6969.7 6969.8 6971.3 6594.3 6633.1 6670.7 6695.1 6702.3 6466.0 6607.2 6617.6 6618.1 6623.8 6924.3 6958.1 6961.2 6963.2 6963.2 4564.9 4602.9 4606.8 4608.3 4611.8 6656.0 6661.3 6664.0 6665.1 6665.9 6354.6 6502.8 6508.4 6510.0 6516.3 6439.3 6469.8 6472.5 6479.5 6490.1 6319.6 6347.6 6352.3 6358.2 6364.5 6510.7 6512.9 6517.1 6519.0 6556.0 5887.7 6135.2 6195.5 6344.9 6365.7 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - PROCESS | 12050 | [#5] yui.html Cycles:180 Average:15246.33 Median:24583.43 stddev:17835.87 (72.6%) stddev-sans-first:17852.70 09:35:19 INFO - PROCESS | 12050 | Values: 753.1 783.7 878.8 885.7 886.6 14394.4 14567.3 14637.9 14677.5 14684.7 14355.9 14439.6 14455.4 14547.2 14574.6 691.9 827.7 828.0 845.6 848.2 834.2 834.6 835.3 836.4 837.4 893.6 896.8 897.0 897.0 897.1 723.7 878.3 886.6 890.0 890.2 644.1 644.2 644.6 644.9 645.4 14885.2 14970.3 14970.9 14995.8 15023.5 13697.5 13997.2 14000.4 14003.4 14592.1 11398.8 11623.4 11719.6 11723.6 11837.6 3785.9 3787.5 3866.1 3886.5 3927.8 54657.9 55004.0 55161.0 55192.4 55199.4 10471.8 10522.4 10628.3 10657.4 10709.9 18932.7 18957.1 19115.7 19119.6 19133.9 7908.4 7926.7 7944.4 8017.6 8150.7 4478.1 4544.2 4620.5 4621.4 4703.3 3286.9 3316.3 3317.4 3326.7 3329.8 567.8 629.5 646.9 690.6 704.1 625.6 625.9 682.9 707.7 776.9 9233.2 9245.3 9256.6 9342.5 9360.7 645.6 661.9 662.5 701.9 710.4 4105.6 4212.5 4218.3 4270.1 4438.4 62989.7 63439.7 63648.0 64017.4 64301.0 56956.0 57306.0 57364.1 57947.7 58523.7 50484.5 51028.2 51729.0 52942.5 53082.7 8750.6 8774.9 8901.2 8965.6 9426.3 37875.0 38162.0 38614.0 39102.2 39740.6 44688.8 48252.4 49065.8 49456.8 51860.2 10839.1 11251.8 11646.9 11759.4 11768.2 12861.0 12941.5 13004.9 13716.7 13764.7 11001.9 12034.6 12257.3 12791.4 12822.8 12519.7 12730.6 12749.3 12987.7 13367.8 12463.2 12760.9 12876.9 13539.5 13722.2 10512.2 10810.6 10826.8 10879.2 11012.2 11040.5 11118.2 11119.4 11122.7 11232.4 09:35:19 INFO - PROCESS | 12050 | -------- Summary: end -------- 09:35:19 INFO - PROCESS | 12050 | 09:35:19 INFO - TEST-INFO | 12050: exit 0 09:35:19 INFO - TEST-OK | dromaeo_css | took 1111765ms 09:35:19 INFO - TEST-START | kraken 09:35:19 INFO - operating with platform_type : linux_ 09:35:19 INFO - Initialising browser for kraken test... 09:35:19 INFO - TEST-INFO | started process 12239 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYefPk/profile http://localhost:42864/getInfo.html) 09:35:23 INFO - PROCESS | 12239 | __metrics Screen width/height:1600/1200 09:35:23 INFO - PROCESS | 12239 | colorDepth:24 09:35:23 INFO - PROCESS | 12239 | Browser inner width/height: 1024/697 09:35:23 INFO - PROCESS | 12239 | __metrics 09:35:24 ERROR - PROCESS | 12239 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:35:24 INFO - PROCESS | 12239 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:35:25 INFO - TEST-INFO | 12239: exit 0 09:35:25 INFO - Browser initialized. 09:35:25 INFO - Running cycle 1/1 for kraken test... 09:35:25 INFO - TEST-INFO | started process 12320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYefPk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:37 INFO - PROCESS | 12320 | RSS: Main: 152842240 09:35:37 INFO - PROCESS | 12320 | 09:35:39 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42864/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:40 INFO - PROCESS | 12320 | RSS: Main: 194650112 09:35:40 INFO - PROCESS | 12320 | 09:35:43 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42864/tests/kraken/driver.html?testName=audio-dft) 09:35:43 INFO - PROCESS | 12320 | RSS: Main: 185044992 09:35:43 INFO - PROCESS | 12320 | 09:35:46 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42864/tests/kraken/driver.html?testName=audio-fft) 09:35:47 INFO - PROCESS | 12320 | RSS: Main: 169533440 09:35:47 INFO - PROCESS | 12320 | 09:35:49 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42864/tests/kraken/driver.html?testName=audio-oscillator) 09:35:49 INFO - PROCESS | 12320 | RSS: Main: 172064768 09:35:49 INFO - PROCESS | 12320 | 09:35:51 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42864/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:52 INFO - PROCESS | 12320 | RSS: Main: 173592576 09:35:52 INFO - PROCESS | 12320 | 09:35:55 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42864/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:56 INFO - PROCESS | 12320 | RSS: Main: 173023232 09:35:56 INFO - PROCESS | 12320 | 09:35:59 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42864/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:00 INFO - PROCESS | 12320 | RSS: Main: 174551040 09:36:00 INFO - PROCESS | 12320 | 09:36:02 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42864/tests/kraken/driver.html?testName=json-parse-financial) 09:36:03 INFO - PROCESS | 12320 | RSS: Main: 175620096 09:36:03 INFO - PROCESS | 12320 | 09:36:04 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42864/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:05 INFO - PROCESS | 12320 | RSS: Main: 184582144 09:36:05 INFO - PROCESS | 12320 | 09:36:07 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:07 INFO - PROCESS | 12320 | RSS: Main: 182108160 09:36:07 INFO - PROCESS | 12320 | 09:36:09 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:10 INFO - PROCESS | 12320 | RSS: Main: 193265664 09:36:10 INFO - PROCESS | 12320 | 09:36:12 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:13 INFO - PROCESS | 12320 | RSS: Main: 198533120 09:36:13 INFO - PROCESS | 12320 | 09:36:15 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:16 INFO - PROCESS | 12320 | RSS: Main: 198352896 09:36:16 INFO - PROCESS | 12320 | 09:36:17 INFO - PROCESS | 12320 | Cycle 1(1): loaded http://localhost:42864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42864/tests/kraken/driver.html?testName=ai-astar) 09:36:18 INFO - PROCESS | 12320 | RSS: Main: 256581632 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | __start_tp_report 09:36:18 INFO - PROCESS | 12320 | _x_x_mozilla_page_load 09:36:18 INFO - PROCESS | 12320 | _x_x_mozilla_page_load_details 09:36:18 INFO - PROCESS | 12320 | |i|pagename|runs| 09:36:18 INFO - PROCESS | 12320 | |0;ai-astar;108;109;104;110;109;109;102;110;108;107 09:36:18 INFO - PROCESS | 12320 | |1;audio-beat-detection;165;125;154;172;126;156;148;125;175;121 09:36:18 INFO - PROCESS | 12320 | |2;audio-dft;160;160;161;161;160;161;162;163;159;162 09:36:18 INFO - PROCESS | 12320 | |3;audio-fft;73;73;101;102;75;75;72;117;92;72 09:36:18 INFO - PROCESS | 12320 | |4;audio-oscillator;93;92;140;92;93;94;136;93;93;139 09:36:18 INFO - PROCESS | 12320 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;117;117;116 09:36:18 INFO - PROCESS | 12320 | |6;imaging-darkroom;145;145;145;146;147;145;146;145;145;145 09:36:18 INFO - PROCESS | 12320 | |7;imaging-desaturate;96;96;96;95;96;95;97;95;95;96 09:36:18 INFO - PROCESS | 12320 | |8;json-parse-financial;55;55;55;54;54;54;56;65;53;52 09:36:18 INFO - PROCESS | 12320 | |9;json-stringify-tinderbox;59;59;59;59;60;60;59;60;59;60 09:36:18 INFO - PROCESS | 12320 | |10;stanford-crypto-aes;76;78;76;77;77;76;78;77;84;77 09:36:18 INFO - PROCESS | 12320 | |11;stanford-crypto-ccm;110;106;110;109;116;109;114;112;110;116 09:36:18 INFO - PROCESS | 12320 | |12;stanford-crypto-pbkdf2;139;139;144;140;139;132;138;137;137;137 09:36:18 INFO - PROCESS | 12320 | |13;stanford-crypto-sha256-iterative;61;61;63;61;64;66;62;61;62;60 09:36:18 INFO - PROCESS | 12320 | __end_tp_report 09:36:18 INFO - PROCESS | 12320 | __start_cc_report 09:36:18 INFO - PROCESS | 12320 | _x_x_mozilla_cycle_collect,1038 09:36:18 INFO - PROCESS | 12320 | __end_cc_report 09:36:18 INFO - PROCESS | 12320 | __startTimestamp1458318978170__endTimestamp 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | ------- Summary: start ------- 09:36:18 INFO - PROCESS | 12320 | Number of tests: 14 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:2.63 (2.4%) stddev-sans-first:2.79 09:36:18 INFO - PROCESS | 12320 | Values: 108.0 109.0 104.0 110.0 109.0 109.0 102.0 110.0 108.0 107.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:155.00 stddev:20.94 (13.5%) stddev-sans-first:21.14 09:36:18 INFO - PROCESS | 12320 | Values: 165.0 125.0 154.0 172.0 126.0 156.0 148.0 125.0 175.0 121.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 09:36:18 INFO - PROCESS | 12320 | Values: 160.0 160.0 161.0 161.0 160.0 161.0 162.0 163.0 159.0 162.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#3] audio-fft Cycles:10 Average:85.20 Median:73.00 stddev:16.48 (22.6%) stddev-sans-first:16.88 09:36:18 INFO - PROCESS | 12320 | Values: 73.0 73.0 101.0 102.0 75.0 75.0 72.0 117.0 92.0 72.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:22.00 (23.7%) stddev-sans-first:22.78 09:36:18 INFO - PROCESS | 12320 | Values: 93.0 92.0 140.0 92.0 93.0 94.0 136.0 93.0 93.0 139.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:36:18 INFO - PROCESS | 12320 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:36:18 INFO - PROCESS | 12320 | Values: 145.0 145.0 145.0 146.0 147.0 145.0 146.0 145.0 145.0 145.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:36:18 INFO - PROCESS | 12320 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 97.0 95.0 95.0 96.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.59 (6.5%) stddev-sans-first:3.81 09:36:18 INFO - PROCESS | 12320 | Values: 55.0 55.0 55.0 54.0 54.0 54.0 56.0 65.0 53.0 52.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:36:18 INFO - PROCESS | 12320 | Values: 59.0 59.0 59.0 59.0 60.0 60.0 59.0 60.0 59.0 60.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:2.37 (3.1%) stddev-sans-first:2.44 09:36:18 INFO - PROCESS | 12320 | Values: 76.0 78.0 76.0 77.0 77.0 76.0 78.0 77.0 84.0 77.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#11] stanford-crypto-ccm Cycles:10 Average:111.20 Median:111.00 stddev:3.26 (2.9%) stddev-sans-first:3.43 09:36:18 INFO - PROCESS | 12320 | Values: 110.0 106.0 110.0 109.0 116.0 109.0 114.0 112.0 110.0 116.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.20 Median:139.00 stddev:3.01 (2.2%) stddev-sans-first:3.18 09:36:18 INFO - PROCESS | 12320 | Values: 139.0 139.0 144.0 140.0 139.0 132.0 138.0 137.0 137.0 137.0 09:36:18 INFO - PROCESS | 12320 | 09:36:18 INFO - PROCESS | 12320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.79 (2.9%) stddev-sans-first:1.86 09:36:18 INFO - PROCESS | 12320 | Values: 61.0 61.0 63.0 61.0 64.0 66.0 62.0 61.0 62.0 60.0 09:36:18 INFO - PROCESS | 12320 | -------- Summary: end -------- 09:36:18 INFO - PROCESS | 12320 | 09:36:19 INFO - TEST-INFO | 12320: exit 0 09:36:19 INFO - TEST-OK | kraken | took 59197ms 09:36:19 INFO - SUITE-END | took 1170s 09:36:19 INFO - Completed test suite (00:19:31) 09:36:19 INFO - javascript benchmark 09:36:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3072.554479600458, 3109.751219902408, 3130.123565401688, 3159.5892533970596, 3163.6994485523874, 5228.4771522847695, 5289.629725919187, 5300.734963251836, 5302.893942121155, 5331.626786124973, 5347.786088556462, 5379.1662292344745, 5394.946050539494, 5411.404745478004, 5451.809186678467, 4797.9760101199445, 4818.734969576672, 4823.1800593899125, 4826.058918510892, 4939.67892087015, 4888.97555512222, 4893.535114164149, 4926.359573255471, 4964.056829202458, 4970.453250142481, 4672.322513235579, 4809.062232864593, 4848.927266091011, 4890.14422476067, 4892.094962431962, 4815.614750819926, 4835.564799168092, 4844.903101937976, 4845.103655823648, 4861.854144375674, 4693.48371679115, 4798.0643774464, 4808.567228949411, 4820.831270905536, 4852.102361063179, 5246.055709972204, 5305.230741542493, 5315.521603055705, 5319.175527793198, 5341.385740639837, 5735.225744524478, 5740.282464691913, 5759.049756790125, 5768.567357448208, 5775.075987841967, 5616.269884914935, 5711.05767548354, 5743.54051675865, 5757.712114394305, 5766.942330576682, 5345.3852806926925, 5359.276497672803, 5380.166074258496, 5407.486288802557, 5409.513143817076, 5868.706564671749, 5873.735681894325, 5874.882502350015, 5875.970620146957, 5879.412058794172, 5510.641808282448, 5645.633033852787, 5658.405867383948, 5688.914666280009, 5745.425457454305, 5765.221695071112, 5774.133879917962, 5774.162746401748, 5788.450097240755, 5805.680687562224, 5711.828645140652, 5735.913961290584, 5761.798337058183, 5763.481286684135, 5765.538756899438, 5558.916616250759, 5726.685032323262, 5728.398518155534, 5806.390329015477, 5839.766409343663, 4396.538363471854, 4398.252297109435, 4399.912001760011, 4401.2517871961845, 4433.534478879671, 3891.922161556753, 3915.4322623219473, 3931.9606803932165, 3967.821448034845, 3977.1449138434796, 5255.264263003182, 5382.0, 5435.211894275308, 5444.782208711607, 5448.45515448452, 5775.48020678141, 5783.0457974434585, 5786.826395208151, 5791.942080579224, 5799.18811366409, 5405.162199859028, 5407.297051383295, 5411.485908838654, 5412.810551630674, 5418.106012507892, 4800.927986080212, 4935.358403407534, 4940.925886111711, 5006.64953453262, 5026.472220416877, 5906.379830117861, 5955.821325360246, 5960.37416071315, 5963.701814909237, 5965.075413310944, 5738.311402631544, 5744.0, 5750.712464376681, 5751.166080918327, 5768.134779783066, 5781.537477001746, 5945.435183657545, 5981.700914954322, 6000.549958753199, 6038.275406951194, 5630.88738225225, 5652.3217213934595, 5670.121131224667, 5670.631408958405, 5670.886582268414, 5542.0855558832345, 5746.195532625519, 5750.6262092963825, 5752.741126649395, 5761.193432919478, 5615.691136987505, 5642.069058605448, 5665.0, 5692.345380281155, 5708.600397972102, 5592.468715472024, 5620.803271885465, 5624.015797235549, 5626.071698169756, 5626.409227031103, 5355.625106242525, 5511.255980442589, 5529.668219906657, 5532.529734972572, 5537.418571050143, 5629.54963602919, 5639.7744090237575, 5654.038813401649, 5654.575906807088, 5712.171735098471, 5489.3687225969525, 5514.310711161105, 5519.448055194609, 5528.19841123043, 5561.749721262472], "unit": "score", "name": "dojo.html", "value": 5287.578843136072}, {"lowerIsBetter": false, "replicates": [558.820312422317, 573.6902072880645, 585.3356440440101, 600.9969950150248, 617.6726335042426, 30874.38251234974, 42721.57278427219, 43094.784526077405, 43190.136197276035, 43231.78384108079, 46208.768956155174, 47030.0, 47085.764571177184, 47152.29271560929, 47173.764131179385, 7892.644830982619, 8643.481391116553, 8857.379983401164, 10060.496975151249, 10226.181905447545, 10213.438260895648, 10339.793204135913, 10348.689539313833, 10351.637692680757, 10351.689449316495, 10340.379577225352, 10431.634892778755, 10434.634787782428, 10435.269531132824, 10440.791184176313, 10241.539130739098, 10321.43232122233, 10331.999999999962, 10337.22470814692, 10351.482425878714, 10370.429626370547, 10517.84223236652, 10534.841977370346, 10536.0, 10539.0, 43003.569964300266, 43051.569484305066, 43154.56845431568, 43201.599800025, 43509.782451087856, 3400.370931377703, 3555.288942211568, 3666.138457462494, 3945.151792364655, 3956.8812935611977, 32875.835620821985, 33058.0, 33398.666013339796, 33784.0, 33827.32345353079, 4182.142660754538, 4306.35404689296, 4317.892052698708, 4375.409319741858, 4391.802368893375, 246417.0, 247959.76020119965, 248047.0, 249575.0, 250643.0, 63852.36147638557, 64330.678346608904, 64346.67826660837, 64374.0, 64440.67779661166, 75404.0, 76581.61709191419, 76854.61572692213, 76877.6156119227, 76886.0, 16004.199790010685, 16300.755488667679, 16421.0, 16438.671226575403, 16440.83559164417, 12243.326617035971, 12379.504819807107, 12387.814182787266, 12391.318477483645, 12392.0, 21878.671819922394, 22154.335369938926, 22203.444913877283, 22214.777852221272, 22264.332070037926, 8136.227058429558, 8390.286825619769, 8456.238938495564, 8468.788280293042, 8524.275436587835, 1070.3249414666022, 1084.9945750271197, 1086.4567716141928, 1097.3470784882982, 1171.8828117188384, 32950.0, 32998.67001329956, 33279.833600831844, 33348.0, 34071.148221294665, 1050.3435352904435, 1094.63876920616, 1113.693734223079, 1149.5516748468103, 1152.608113241502, 14996.775048374284, 15004.24978751058, 15034.69930601382, 15070.698586028218, 15302.158381289137, 316303.0, 318796.0, 319485.0, 319512.0, 319970.0, 52520.47479525156, 52831.0, 52996.0, 53093.73453132709, 53135.46864531305, 1190.892819646236, 1289.4842063174617, 1345.387848528917, 1375.326090215787, 1386.9930650346685, 28937.13188604345, 29863.402731944803, 30274.24314392158, 30291.242718932204, 30588.847055764578, 42388.576114238465, 42533.57466425296, 43027.0, 43046.35430468483, 43112.0, 205897.0, 206006.0, 206244.0, 206854.0, 207641.0, 31677.20806979844, 36136.63863361333, 36731.0, 37023.44464832976, 37055.814720926224, 42957.785211073744, 43049.354259686756, 43068.138637227705, 43387.56612433962, 43477.347839781796, 37256.254874902894, 38207.235855283296, 39051.0, 39232.2153556933, 39354.803225983684, 37734.43398348972, 38130.809345953094, 38188.28152733078, 38509.0, 38865.0, 38695.22609547737, 39978.80010599928, 40462.59537404706, 40724.0, 40732.38901416422, 33997.49003764995, 36734.265314693024, 36979.44530832094, 37220.62779372172, 37246.25507489781, 26022.0, 26252.606210907234, 26255.868720656275, 26279.868600656875, 26619.46761064729], "unit": "score", "name": "ext.html", "value": 19704.889148157246}, {"lowerIsBetter": false, "replicates": [373.9663430291273, 376.78899816102984, 382.3251960290087, 385.731916318159, 389.1108816354629, 17833.821661783393, 18033.0, 18739.250429982818, 18771.90614046928, 18790.718139227905, 17693.91153044236, 18315.17581708823, 19114.904425477853, 19126.808731912675, 19148.0, 5513.2005859150295, 5631.63394379366, 5656.2929633795775, 5666.801661941833, 5670.461306175927, 4119.237940980913, 5635.718214089299, 5973.731182096794, 6223.7510499580185, 6240.812775616716, 6206.503479721634, 6221.0979407985815, 6226.37736226376, 6228.159198508189, 6230.719617617196, 5875.7062146892695, 6082.452579267887, 6086.056661217518, 6095.329513753483, 6096.146539484475, 3705.073731567108, 5292.470752924715, 5394.0, 5521.199426083235, 5523.4200408956885, 20768.896155519276, 20843.478913027146, 20882.686759698616, 22459.32622021342, 22495.0, 2377.3511923948577, 2380.4643955110137, 2386.129062892032, 2424.175780234729, 2444.99755100408, 13870.653233669138, 13906.443742250298, 13939.581812545639, 14145.080569762933, 14527.70944581113, 1954.99022504888, 1994.8813586223282, 2009.1862795567818, 2017.213286818142, 2034.0541648133542, 69499.65250173716, 71885.2811471889, 72396.27603724001, 72438.63780681063, 72891.63554182195, 10503.52734126966, 10516.421596812248, 10936.945315273373, 10991.670249892515, 11155.386453744959, 14123.364448599837, 14258.358373873201, 14262.072965257224, 14269.143851368952, 14274.714505709828, 7961.0, 8151.836963260702, 8163.142869998684, 8230.8353832923, 8287.875681864776, 7432.777016689508, 7531.209223031503, 7896.692586625645, 7951.363890888715, 8036.557989310527, 6587.422473095766, 6736.730530778714, 6767.458603311723, 6776.356246156607, 6858.417034552119, 1698.3036954848453, 1821.253286152671, 1882.4917272336393, 1885.1611033090417, 1890.5084677983823, 429.5554101504927, 432.4507874998797, 953.9189168920719, 1046.3109807793896, 1121.2711737370773, 10829.458527073615, 11371.54513819438, 11420.14348923834, 11481.71295717597, 11612.187146899805, 454.94768101668734, 459.010831657778, 460.1625042422758, 463.3767582601396, 475.14948242645966, 6142.355052719489, 6214.316425193225, 6260.780872669526, 6371.872562548723, 6379.744810207632, 517952.0, 530435.0, 531805.0, 531813.0, 543045.0, 79734.20265797384, 79891.0, 80710.5964470174, 80929.59535202404, 85707.0, 480.224437533388, 481.8265424447266, 483.8137317132859, 484.70433035848106, 485.65761138397346, 10520.947395262974, 10838.241323107306, 10856.565737370416, 10906.509207085859, 11020.283681560673, 35713.46429803607, 36608.35262413145, 36687.63312366949, 36688.81655591705, 36773.26453470969, 50723.23915141202, 54909.0, 55061.72469137629, 55161.0, 55732.16401754058, 8200.138985406445, 8261.83476330482, 8331.250187483156, 8399.496030238206, 8532.488050716976, 9395.201407880406, 12165.513379464723, 12264.141510094565, 12675.873241267469, 12705.872941270469, 6554.4756419485375, 7481.625918704151, 11214.719632009264, 11377.374244416636, 11605.245659032136, 10711.464426778473, 10868.945655271673, 10989.120870330515, 11151.163662725166, 11156.944215279196, 11419.143564232882, 11444.82832757526, 11571.537138514364, 11587.942060289644, 11641.6507504775, 8043.235892590194, 8121.79695507617, 8129.715459958873, 8217.876731848908, 8416.11630778784, 9796.363236389612, 11073.723156921142, 11132.0, 11223.0, 11250.83123753128], "unit": "score", "name": "jquery.html", "value": 8312.006837796513}, {"lowerIsBetter": false, "replicates": [1286.6075846866702, 1514.1066770605341, 1525.2907398059904, 1708.0947098038037, 1840.2179073893592, 7986.201379862011, 8163.632636531355, 8170.305524030449, 8170.877436838452, 8175.264226219639, 7901.209879012096, 8052.63763130659, 8068.757937261891, 8072.757817265477, 8076.676932922691, 2044.5297581556251, 2337.076854642415, 2378.916737914173, 2383.84505007174, 2402.6876506054186, 2377.0, 2388.355144111089, 2389.2593296078185, 2392.605220138675, 2394.844335118212, 2296.0930432479163, 2358.917437889674, 2361.669366288721, 2365.231299827563, 2365.3495288795634, 2318.9072437102495, 2328.1502251678185, 2358.516504116652, 2359.728631207416, 2367.8460900041528, 2358.740538540759, 2391.246757271454, 2397.3167647220457, 2405.230326295586, 2408.0608562660577, 8285.047219569766, 8302.875456868152, 8325.333973282184, 8328.958355208246, 8353.122922093153, 5143.485651434864, 5230.3985041719925, 5260.473952604747, 5264.078786212436, 5268.473152684739, 3433.364827506919, 3558.5729712434413, 3569.411047177213, 3585.8386372613295, 3636.8727094551564, 1167.486306025346, 1178.2930241854904, 1184.5025089462447, 1215.7143071378218, 1268.543324403214, 11587.594434194847, 11703.0, 11735.706607334885, 11741.178117531776, 11744.29534227949, 4651.302304654261, 4692.1554120258, 4770.332153498513, 4775.856724298207, 4778.04439112179, 9878.851817222747, 9919.603215871284, 9936.602535898483, 9948.353357031914, 9960.551775170135, 4526.366308716782, 5241.50205730455, 5244.606654500928, 5245.423003469616, 5245.947540524546, 4642.814287428532, 4663.860084197479, 4703.905921881543, 4719.646026548023, 4725.4565724941385, 4007.779572123561, 4038.919221615551, 4057.9391309130388, 4075.5109386873764, 4091.0, 1285.575759999198, 1303.1529505821293, 1304.6281809684194, 1304.9673758155932, 1309.0574786153954, 1384.2386687321932, 1395.6301580081285, 1398.7692030815006, 1406.6694326833185, 1414.9504767333094, 7863.0957439894, 7962.56205908669, 8008.599570021475, 8023.237792409712, 8023.558704271204, 507.1631807517625, 509.55923126496054, 513.1481740311066, 514.9176131818891, 518.0700642346997, 6187.969060154761, 6204.100405441186, 6216.782412615627, 6260.655663938436, 6274.560780745304, 9371.0, 9598.0, 9608.95195524018, 9643.614255429844, 9761.170300524393, 9512.0, 9619.807603847883, 9636.42181469114, 9646.807063858683, 9683.83793944717, 7928.048634163937, 8010.959945200353, 8012.679492820338, 8080.39397045224, 8102.068262149928, 7899.052113746157, 7911.762647120596, 7989.081255655442, 7997.400194985516, 8032.598370081356, 9017.594208260512, 9244.399114057565, 9278.860817087614, 9351.579178936829, 9542.141207291377, 9349.813003740022, 9385.48379839088, 9569.234461242944, 9628.614855405705, 9779.168770654574, 6619.437347825488, 6796.72813087471, 7232.819179520554, 7394.704211831467, 7482.70069197226, 7947.5231486108705, 7962.163972783006, 7963.601819909098, 7994.680212791656, 8003.399745019264, 7043.647817608997, 7069.929300706927, 7127.786166415016, 7282.854342913218, 7309.378702810321, 7030.894536581853, 7045.894311585228, 7053.858922821412, 7117.252688467636, 7147.356737893615, 7169.641517924188, 7170.067891174114, 7187.02975098355, 7192.568445893263, 7198.6040767756185, 6922.757703480354, 6926.168859736864, 6981.371676549135, 6997.405220556309, 7003.509754317149, 6980.895286570807, 6991.930080699128, 6993.4055605274125, 7013.368796808311, 7122.145342558926], "unit": "score", "name": "mootools.html", "value": 4720.143584547052}, {"lowerIsBetter": false, "replicates": [341.74369223082687, 344.1413672886148, 344.29763282902877, 344.9844756985936, 351.6079571278024, 6008.098785182225, 6031.035034394497, 6065.545084118687, 6084.604500707456, 6097.237845269336, 5971.343152253248, 5973.761049558012, 5977.432143946329, 5985.371535988724, 5986.910196347058, 4355.34669799531, 4495.617872480843, 4547.909041819162, 4582.702124361923, 4585.72485650862, 4582.1293954148605, 4583.610393116589, 4592.540745925414, 4601.0, 4602.815887364502, 4534.6372290216705, 4539.523350048247, 4543.1140927519145, 4544.227481328182, 4552.613027892633, 4334.674899382543, 4495.5729205725565, 4562.5665561771575, 4586.885327866797, 4590.678652494294, 4004.199160167949, 4011.2378648056774, 4015.4980627421573, 4022.35642297231, 4045.615666511677, 5776.884462310731, 5785.47930686236, 5802.303723553201, 5813.302403711539, 5821.3014438267255, 5419.458054194549, 5427.674339539641, 5427.782888684448, 5428.212909128194, 5432.75552600134, 6373.107764912916, 6387.68061596923, 6388.64862432566, 6394.328595497453, 6405.29541750407, 4374.4531933508315, 4488.910221795546, 4513.977430112861, 4522.5025247222775, 4523.84166554169, 6649.966750166266, 6707.128073350482, 6732.29310922351, 6733.663316834139, 6737.258901520878, 4685.0629874025335, 4685.226937555265, 4686.156491831435, 4686.437627484655, 4692.788824502837, 4753.881152971203, 4756.952430475721, 4757.6193904488255, 4759.571638552547, 4761.642876784255, 5422.48486393792, 5424.1321388577635, 5435.701036442954, 5444.047291723932, 5445.0, 6334.271558770801, 6465.450436712838, 6475.449586785082, 6497.902531462032, 6505.544611877218, 1657.4696097249005, 1666.5916850371736, 1674.2800595743947, 1677.0189439178218, 1677.429673910876, 1046.858674079005, 1124.6063877642923, 1126.9267497612793, 1162.8953394194564, 1165.7901577716093, 6070.2108725865355, 6071.605345652519, 6072.787452439232, 6078.270607527125, 6082.726277317532, 6503.219613646393, 6511.38141876521, 6526.118973938457, 6529.738810447624, 6545.181852268466, 6074.51403887688, 6078.483328917003, 6079.726412311456, 6085.665288409092, 6087.269527656621, 3492.5285086513504, 3530.0998245447245, 3530.646935306449, 3532.3288575170636, 3535.151563624763, 6722.798316050428, 6785.694643741043, 6980.965095174492, 6995.8600827983155, 6997.440204783605, 6774.0, 6845.452363810883, 6854.760083397157, 6854.862902741917, 6856.4514838813775, 6957.060796792368, 6958.130233720785, 6969.6515174241085, 6969.815131427771, 6971.3028697129885, 6594.340565943559, 6633.1045308882685, 6670.699818508082, 6695.129633147854, 6702.296258892941, 6466.0, 6607.174103236903, 6617.569857959217, 6618.139641846529, 6623.834404139935, 6924.3421874921805, 6958.095447591781, 6961.199462061928, 6963.199232088172, 6963.2340442552295, 4564.863054108382, 4602.907941841211, 4606.769661516978, 4608.262677971643, 4611.769411529343, 6655.966720166562, 6661.267260601427, 6664.0, 6665.100211471389, 6665.866682666223, 6354.555181137276, 6502.837429064122, 6508.414242718178, 6510.0, 6516.250631177475, 6439.323870993666, 6469.805905822833, 6472.514561407819, 6479.514036447191, 6490.123833282635, 6319.6208227506495, 6347.619142851444, 6352.301246862749, 6358.1734374531015, 6364.459020983269, 6510.707018184098, 6512.869742605216, 6517.087607735016, 6519.0, 6556.0, 5887.712217247657, 6135.171751813448, 6195.504359651307, 6344.936550634619, 6365.745370185326], "unit": "score", "name": "prototype.html", "value": 4862.741940201672}, {"lowerIsBetter": false, "replicates": [753.0624372656042, 783.6512751825436, 878.7671267114216, 885.7475619448459, 886.6010295367087, 14394.352254148562, 14567.344469498872, 14637.92681036596, 14677.486287979922, 14684.70630587389, 14355.928220358883, 14439.639009024753, 14455.421783128662, 14547.199904005276, 14574.635634109127, 691.9481038922075, 827.6606591297555, 828.0477450931447, 845.6363763581688, 848.1560846957286, 834.1741675741004, 834.6369329341726, 835.2691395029349, 836.3810780022769, 837.3677873205721, 893.5532233883058, 896.8430524658191, 897.0356866368647, 897.0491279244022, 897.0670502677208, 723.6924307169459, 878.3324673248345, 886.5965985476593, 889.9822003559957, 890.1765866573459, 644.0661041489858, 644.1979735229622, 644.622895606071, 644.9226092868839, 645.3578689204224, 14885.181315027668, 14970.326335314829, 14970.925145374204, 14995.775063374058, 15023.549293521211, 13697.520586779514, 13997.160170389809, 14000.439982400692, 14003.369848356848, 14592.124472531576, 11398.772024559545, 11623.418829058597, 11719.648410547697, 11723.648290551297, 11837.585684501, 3785.886423407302, 3787.4886890269736, 3866.1107945172485, 3886.5336159660737, 3927.8232479538206, 54657.90684186334, 55004.0, 55161.0, 55192.44807551953, 55199.44800551983, 10471.790564188674, 10522.368657880552, 10628.309159904582, 10657.360558366523, 10709.892901070889, 18932.71600925987, 18957.146928388254, 19115.71326430105, 19119.617607647768, 19133.904330478257, 7908.446408751447, 7926.682932682628, 7944.404169687181, 8017.599120044091, 8150.7147249845975, 4478.081993191388, 4544.159330523864, 4620.4686461056735, 4621.4223222097235, 4703.294505824154, 3286.901392958215, 3316.3035762489667, 3317.419451595961, 3326.6507016763376, 3329.8002119872885, 567.821136342051, 629.4555209743539, 646.873859597374, 690.6339639990813, 704.0987535953988, 625.5808608232495, 625.9296602809247, 682.9419499342512, 707.678006507038, 776.9184235655288, 9233.215176710055, 9245.306602004743, 9256.629734810667, 9342.532873356306, 9360.719178424659, 645.554567348528, 661.9007148927699, 662.5461558832216, 701.8806802843427, 710.3713213805819, 4105.630493255561, 4212.515560710496, 4218.282891908383, 4270.145970805851, 4438.35643831649, 62989.68505157445, 63439.68280158662, 63648.0, 64017.35982640114, 64301.0, 56956.0, 57306.0, 57364.139537906965, 57947.71026144927, 58523.70738146282, 50484.49515504872, 51028.23457648212, 51729.0, 52942.47057529375, 53082.73458632682, 8750.606222719865, 8774.868376974478, 8901.243394311556, 8965.596548155218, 9426.293028023063, 37875.0, 38162.0, 38614.0, 39102.21795564016, 39740.602593973694, 44688.77655611701, 48252.416020478, 49065.754671226416, 49456.75271623619, 51860.222096669335, 10839.078678312117, 11251.831222531504, 11646.94176529112, 11759.353235572125, 11768.176227664324, 12861.0, 12941.482340706267, 13004.869951300745, 13716.65708357259, 13764.65588360299, 11001.944990274997, 12034.63896083119, 12257.325847078497, 12791.424385902843, 12822.807657884952, 12519.749605008032, 12730.554430594884, 12749.298788566717, 12987.675308117372, 13367.799483007568, 12463.189892656948, 12760.936195318964, 12876.935615321863, 13539.458421663023, 13722.245276509888, 10512.211584131373, 10810.567577297135, 10826.837597436202, 10879.184061195283, 11012.17408694335, 11040.503177356877, 11118.166137539554, 11119.388433636228, 11122.721931951766, 11232.382218978035], "unit": "score", "name": "yui.html", "value": 6827.57389900385}], "name": "dromaeo_css", "value": 7168.796300376122}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 110.0, 109.0, 109.0, 102.0, 110.0, 108.0, 107.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [165.0, 125.0, 154.0, 172.0, 126.0, 156.0, 148.0, 125.0, 175.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 159.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 101.0, 102.0, 75.0, 75.0, 72.0, 117.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 140.0, 92.0, 93.0, 94.0, 136.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 147.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 56.0, 65.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.4}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 76.0, 77.0, 77.0, 76.0, 78.0, 77.0, 84.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.6}, {"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 109.0, 116.0, 109.0, 114.0, 112.0, 110.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.2}, {"lowerIsBetter": true, "replicates": [139.0, 139.0, 144.0, 140.0, 139.0, 132.0, 138.0, 137.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.2}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 63.0, 61.0, 64.0, 66.0, 62.0, 61.0, 62.0, 60.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.1}], "name": "kraken", "value": 1468.3999999999999}]} 09:36:19 INFO - Return code: 0 09:36:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:36:19 ERROR - # TBPL SUCCESS # 09:36:19 INFO - Running post-action listener: _resource_record_post_action 09:36:19 INFO - Running post-run listener: _resource_record_post_run 09:36:20 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545685504; Read time: 180; Write time: 693020 09:36:20 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 249880576; Read time: 0; Write time: 439480 09:36:20 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295804928; Read time: 180; Write time: 253540 09:36:20 INFO - Running post-run listener: _upload_blobber_files 09:36:20 INFO - Blob upload gear active. 09:36:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:36:20 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 09:36:20 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'] 09:36:20 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 09:36:21 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:21 INFO - (blobuploader) - INFO - Done attempting. 09:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:22 INFO - (blobuploader) - INFO - Done attempting. 09:36:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:22 INFO - Return code: 0 09:36:22 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:36:22 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15f196484e5310068d2449128cc652c66a222be393cdf93f91c7770bc579ca285715dffc1f1e55eab75116a34833d49fa3608b48ff3eba0340c4d2ffb17238d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635995b95f3f6eb506ba40b8f757d922feb62b15b88487a29e0f4d79198931e97467fb1281fadaa517df86f7935d82f968c24ee08c018a7f25d1f4ec2506fcd7"} 09:36:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:36:22 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:36:22 INFO - Contents: 09:36:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15f196484e5310068d2449128cc652c66a222be393cdf93f91c7770bc579ca285715dffc1f1e55eab75116a34833d49fa3608b48ff3eba0340c4d2ffb17238d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635995b95f3f6eb506ba40b8f757d922feb62b15b88487a29e0f4d79198931e97467fb1281fadaa517df86f7935d82f968c24ee08c018a7f25d1f4ec2506fcd7"} 09:36:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:22 INFO - Copying logs to upload dir... 09:36:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:36:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.281382 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-18 09:36:22.081543) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:36:22.085348) ========= 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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15f196484e5310068d2449128cc652c66a222be393cdf93f91c7770bc579ca285715dffc1f1e55eab75116a34833d49fa3608b48ff3eba0340c4d2ffb17238d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635995b95f3f6eb506ba40b8f757d922feb62b15b88487a29e0f4d79198931e97467fb1281fadaa517df86f7935d82f968c24ee08c018a7f25d1f4ec2506fcd7"} build_url:https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/B5Hl912oTFeDJ1azgbsOTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15f196484e5310068d2449128cc652c66a222be393cdf93f91c7770bc579ca285715dffc1f1e55eab75116a34833d49fa3608b48ff3eba0340c4d2ffb17238d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635995b95f3f6eb506ba40b8f757d922feb62b15b88487a29e0f4d79198931e97467fb1281fadaa517df86f7935d82f968c24ee08c018a7f25d1f4ec2506fcd7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:36:22.110086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:36:22.110408) ========= 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=d2a8c569965ab8367867b893000001a1-1458317754.794334-204258561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:36:22.192606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:36:22.192916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:36:22.193197) ========= ========= Total master_lag: 0.32 =========