builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1458691859.46 results: success (0) buildid: 20160322143109 builduid: c02f6022c1474de693690cfd6113796e revision: abfac0d05b79b49597d5fa8d4ce87caf4caaff8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 17:10:59.463498) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 17:10:59.464052) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 17:10:59.464356) ========= 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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006409 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 17:10:59.639945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 17:10:59.640276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.091054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.091348) ========= 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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.302523) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.302823) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.303172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.303493) ========= 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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-22 17:11:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.9M=0s 2016-03-22 17:11:01 (71.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.585361 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.982259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:00.982628) ========= 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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013734 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:01.190777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-22 17:11:01.191131) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev abfac0d05b79b49597d5fa8d4ce87caf4caaff8e --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 abfac0d05b79b49597d5fa8d4ce87caf4caaff8e --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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-22 17:11:01,774 truncating revision to first 12 chars 2016-03-22 17:11:01,774 Setting DEBUG logging. 2016-03-22 17:11:01,774 attempt 1/10 2016-03-22 17:11:01,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/abfac0d05b79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 17:11:03,163 unpacking tar archive at: fx-team-abfac0d05b79/testing/mozharness/ program finished with exit code 0 elapsedTime=2.149019 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-22 17:11:03.464596) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:03.464905) ========= echo abfac0d05b79b49597d5fa8d4ce87caf4caaff8e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'abfac0d05b79b49597d5fa8d4ce87caf4caaff8e'] 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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False abfac0d05b79b49597d5fa8d4ce87caf4caaff8e program finished with exit code 0 elapsedTime=0.004163 script_repo_revision: 'abfac0d05b79b49597d5fa8d4ce87caf4caaff8e' ========= master_lag: 0.34 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:03.811485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:03.812007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 17:11:04.534553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 38 secs) (at 2016-03-22 17:11:04.534961) ========= /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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:05 INFO - MultiFileLogger online at 20160322 17:11:05 in /builds/slave/test-pgo 17:11:05 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 17:11:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:11:05 INFO - {'append_to_log': False, 17:11:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:11:05 INFO - 'blob_upload_branch': 'Fx-Team', 17:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:11:05 INFO - 'branch': 'Fx-Team', 17:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:05 INFO - 'config_files': ('talos/linux_config.py',), 17:11:05 INFO - 'default_actions': ('clobber', 17:11:05 INFO - 'read-buildbot-config', 17:11:05 INFO - 'download-and-extract', 17:11:05 INFO - 'populate-webroot', 17:11:05 INFO - 'create-virtualenv', 17:11:05 INFO - 'install', 17:11:05 INFO - 'run-tests'), 17:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:05 INFO - 'download_minidump_stackwalk': True, 17:11:05 INFO - 'download_symbols': 'ondemand', 17:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:05 INFO - 'installer_path': 'installer.exe', 17:11:05 INFO - 'log_level': 'info', 17:11:05 INFO - 'log_name': 'talos', 17:11:05 INFO - 'log_to_console': True, 17:11:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:05 INFO - 'opt_config_files': (), 17:11:05 INFO - 'pip_index': False, 17:11:05 INFO - 'sps_profile': False, 17:11:05 INFO - 'sps_profile_interval': 0, 17:11:05 INFO - 'suite': 'dromaeojs', 17:11:05 INFO - 'system_bits': '32', 17:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:05 INFO - 'title': 'talos-linux64-ix-029', 17:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:05 INFO - 'use_talos_json': True, 17:11:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:05 INFO - 'work_dir': 'build'} 17:11:05 INFO - ##### 17:11:05 INFO - ##### Running clobber step. 17:11:05 INFO - ##### 17:11:05 INFO - Running pre-action listener: _resource_record_pre_action 17:11:05 INFO - Running main action method: clobber 17:11:05 INFO - rmtree: /builds/slave/test-pgo/build 17:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:11:06 INFO - Running post-action listener: _resource_record_post_action 17:11:06 INFO - ##### 17:11:06 INFO - ##### Running read-buildbot-config step. 17:11:06 INFO - ##### 17:11:06 INFO - Running pre-action listener: _resource_record_pre_action 17:11:06 INFO - Running main action method: read_buildbot_config 17:11:06 INFO - Using buildbot properties: 17:11:06 INFO - { 17:11:06 INFO - "project": "", 17:11:06 INFO - "product": "firefox", 17:11:06 INFO - "script_repo_revision": "production", 17:11:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:11:06 INFO - "repository": "", 17:11:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:11:06 INFO - "buildid": "20160322143109", 17:11:06 INFO - "pgo_build": "True", 17:11:06 INFO - "basedir": "/builds/slave/test-pgo", 17:11:06 INFO - "buildnumber": 555, 17:11:06 INFO - "slavename": "talos-linux64-ix-029", 17:11:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:11:06 INFO - "platform": "ubuntu64_hw", 17:11:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:11:06 INFO - "branch": "fx-team", 17:11:06 INFO - "repo_path": "integration/fx-team", 17:11:06 INFO - "revision": "abfac0d05b79b49597d5fa8d4ce87caf4caaff8e", 17:11:06 INFO - "stage_platform": "linux64-pgo", 17:11:06 INFO - "builduid": "c02f6022c1474de693690cfd6113796e", 17:11:06 INFO - "slavebuilddir": "test" 17:11:06 INFO - } 17:11:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:11:06 INFO - Running post-action listener: _resource_record_post_action 17:11:06 INFO - ##### 17:11:06 INFO - ##### Running download-and-extract step. 17:11:06 INFO - ##### 17:11:06 INFO - Running pre-action listener: _resource_record_pre_action 17:11:06 INFO - Running main action method: download_and_extract 17:11:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:11:06 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')]} 17:11:06 INFO - https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:11:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:11:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:11:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:11:15 INFO - Downloaded 1361 bytes. 17:11:15 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:11:15 INFO - Using the following test package requirements: 17:11:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:11:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:11:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'jsshell-linux-x86_64.zip'], 17:11:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:11:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:11:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:11:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:11:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:11:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:15 INFO - https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:11:23 INFO - Downloaded 23572550 bytes. 17:11:23 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'] 17:11:23 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 17:11:24 INFO - Return code: 0 17:11:24 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 17:11: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')]} 17:11:24 INFO - https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:12:14 INFO - Downloaded 23572550 bytes. 17:12:14 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'] 17:12:14 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 17:12:16 INFO - Return code: 0 17:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:16 INFO - https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:12:20 INFO - Downloaded 10848120 bytes. 17:12:20 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'] 17:12:20 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 17:12:20 INFO - Return code: 0 17:12: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')]} 17:12:20 INFO - https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SIYgXPE_SPOioVPCcykNxQ/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 17:12:26 INFO - Downloaded 57734133 bytes. 17:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:26 INFO - mkdir: /builds/slave/test-pgo/properties 17:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:12:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:12:26 INFO - Contents: 17:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:31 INFO - Running post-action listener: _resource_record_post_action 17:12:31 INFO - Running post-action listener: set_extra_try_arguments 17:12:31 INFO - ##### 17:12:31 INFO - ##### Running populate-webroot step. 17:12:31 INFO - ##### 17:12:31 INFO - Running pre-action listener: _resource_record_pre_action 17:12:31 INFO - Running main action method: populate_webroot 17:12:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:31 INFO - '--tppagecycles', 17:12:31 INFO - '7'], 17:12:31 INFO - 'tests': ['tsvgm']}}, 17:12:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:12:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:12:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'tests': ['damp', 'tps']}, 17:12:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['damp', 'tps']}, 17:12:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:12:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:31 INFO - 'other': {'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other_l64': {'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other_nol64': {'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'svgr': {'tests': ['tsvgx', 17:12:31 INFO - 'tsvgr_opacity', 17:12:31 INFO - 'tart', 17:12:31 INFO - 'tscrollx', 17:12:31 INFO - 'cart']}, 17:12:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['tsvgx', 17:12:31 INFO - 'tsvgr_opacity', 17:12:31 INFO - 'tart', 17:12:31 INFO - 'tscrollx', 17:12:31 INFO - 'cart']}, 17:12:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'tests': ['tp5o']}, 17:12:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--e10s'], 17:12:31 INFO - 'tests': ['tp5o']}, 17:12:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--xperf_path', 17:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:31 INFO - 'tests': ['tp5n']}, 17:12:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--e10s', 17:12:31 INFO - '--xperf_path', 17:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:31 INFO - 'tests': ['tp5n']}}, 17:12:31 INFO - 'talos.zip': {'path': '', 17:12:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:31 INFO - Running post-action listener: _resource_record_post_action 17:12:31 INFO - ##### 17:12:31 INFO - ##### Running create-virtualenv step. 17:12:31 INFO - ##### 17:12:31 INFO - Running pre-action listener: _resource_record_pre_action 17:12:31 INFO - Running main action method: create_virtualenv 17:12:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:12:31 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 17:12:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:12:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:31 INFO - Using real prefix '/usr' 17:12:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:12:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:34 INFO - Installing pip.................done. 17:12:34 INFO - Return code: 0 17:12:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:12:34 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 17:12:34 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 17:12:34 INFO - Using env: {'DISPLAY': ':0', 17:12:34 INFO - 'HOME': '/home/cltbld', 17:12:34 INFO - 'LANG': 'en_US.UTF-8', 17:12:34 INFO - 'LANGUAGE': 'en_US:en', 17:12:34 INFO - 'LOGNAME': 'cltbld', 17:12:34 INFO - 'MAIL': '/var/mail/cltbld', 17:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:34 INFO - 'MOZ_NO_REMOTE': '1', 17:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:34 INFO - 'NO_EM_RESTART': '1', 17:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:34 INFO - 'SHELL': '/bin/bash', 17:12:34 INFO - 'SHLVL': '1', 17:12:34 INFO - 'TERM': 'linux', 17:12:34 INFO - 'TMOUT': '86400', 17:12:34 INFO - 'USER': 'cltbld', 17:12:34 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:34 INFO - '_': '/tools/buildbot/bin/python'} 17:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:34 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 17:12:34 INFO - Cleaning up... 17:12:34 INFO - Return code: 0 17:12:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:12:34 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 17:12:34 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 17:12:34 INFO - Using env: {'DISPLAY': ':0', 17:12:34 INFO - 'HOME': '/home/cltbld', 17:12:34 INFO - 'LANG': 'en_US.UTF-8', 17:12:34 INFO - 'LANGUAGE': 'en_US:en', 17:12:34 INFO - 'LOGNAME': 'cltbld', 17:12:34 INFO - 'MAIL': '/var/mail/cltbld', 17:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:34 INFO - 'MOZ_NO_REMOTE': '1', 17:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:34 INFO - 'NO_EM_RESTART': '1', 17:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:34 INFO - 'SHELL': '/bin/bash', 17:12:34 INFO - 'SHLVL': '1', 17:12:34 INFO - 'TERM': 'linux', 17:12:34 INFO - 'TMOUT': '86400', 17:12:34 INFO - 'USER': 'cltbld', 17:12:34 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:34 INFO - '_': '/tools/buildbot/bin/python'} 17:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:34 INFO - Downloading/unpacking psutil>=0.7.1 17:12:34 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 17:12:34 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 17:12:34 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 17:12:34 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 17:12:34 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 17:12:34 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 17:12:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:58 INFO - Installing collected packages: psutil 17:12:58 INFO - Running setup.py install for psutil 17:12:59 INFO - building 'psutil._psutil_linux' extension 17:12:59 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 17:12:59 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 17:12:59 INFO - building 'psutil._psutil_posix' extension 17:12:59 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 17:12:59 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 17:12:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:59 INFO - Successfully installed psutil 17:12:59 INFO - Cleaning up... 17:12:59 INFO - Return code: 0 17:12:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:12:59 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')]} 17:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:59 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')]} 17:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:59 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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:12:59 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 17:12:59 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 17:12:59 INFO - Using env: {'DISPLAY': ':0', 17:12:59 INFO - 'HOME': '/home/cltbld', 17:12:59 INFO - 'LANG': 'en_US.UTF-8', 17:12:59 INFO - 'LANGUAGE': 'en_US:en', 17:12:59 INFO - 'LOGNAME': 'cltbld', 17:12:59 INFO - 'MAIL': '/var/mail/cltbld', 17:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:59 INFO - 'MOZ_NO_REMOTE': '1', 17:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:59 INFO - 'NO_EM_RESTART': '1', 17:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:12:59 INFO - 'PWD': '/builds/slave/test-pgo', 17:12:59 INFO - 'SHELL': '/bin/bash', 17:12:59 INFO - 'SHLVL': '1', 17:12:59 INFO - 'TERM': 'linux', 17:12:59 INFO - 'TMOUT': '86400', 17:12:59 INFO - 'USER': 'cltbld', 17:12:59 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:59 INFO - '_': '/tools/buildbot/bin/python'} 17:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:13:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:13:11 INFO - Installing collected packages: mozsystemmonitor 17:13:11 INFO - Running setup.py install for mozsystemmonitor 17:13:11 INFO - Successfully installed mozsystemmonitor 17:13:11 INFO - Cleaning up... 17:13:11 INFO - Return code: 0 17:13:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:13: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')]} 17:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', '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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:13: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:13: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 blobuploader==1.2.4 17:13:11 INFO - Using env: {'DISPLAY': ':0', 17:13:11 INFO - 'HOME': '/home/cltbld', 17:13:11 INFO - 'LANG': 'en_US.UTF-8', 17:13:11 INFO - 'LANGUAGE': 'en_US:en', 17:13:11 INFO - 'LOGNAME': 'cltbld', 17:13:11 INFO - 'MAIL': '/var/mail/cltbld', 17:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:11 INFO - 'MOZ_NO_REMOTE': '1', 17:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:11 INFO - 'NO_EM_RESTART': '1', 17:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:13:11 INFO - 'PWD': '/builds/slave/test-pgo', 17:13:11 INFO - 'SHELL': '/bin/bash', 17:13:11 INFO - 'SHLVL': '1', 17:13:11 INFO - 'TERM': 'linux', 17:13:11 INFO - 'TMOUT': '86400', 17:13:11 INFO - 'USER': 'cltbld', 17:13:11 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:11 INFO - '_': '/tools/buildbot/bin/python'} 17:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:11 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 17:13:11 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 17:13:11 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 17:13:11 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 17:13:11 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 17:13:11 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 17:13:16 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:13:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:17 INFO - Downloading docopt-0.6.1.tar.gz 17:13:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:17 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:17 INFO - Running setup.py install for blobuploader 17:13:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:13:17 INFO - Running setup.py install for requests 17:13:18 INFO - Running setup.py install for docopt 17:13:18 INFO - Successfully installed blobuploader requests docopt 17:13:18 INFO - Cleaning up... 17:13:18 INFO - Return code: 0 17:13:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:13:18 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 17:13:18 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 17:13:18 INFO - Using env: {'DISPLAY': ':0', 17:13:18 INFO - 'HOME': '/home/cltbld', 17:13:18 INFO - 'LANG': 'en_US.UTF-8', 17:13:18 INFO - 'LANGUAGE': 'en_US:en', 17:13:18 INFO - 'LOGNAME': 'cltbld', 17:13:18 INFO - 'MAIL': '/var/mail/cltbld', 17:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:18 INFO - 'MOZ_NO_REMOTE': '1', 17:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:18 INFO - 'NO_EM_RESTART': '1', 17:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:13:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:13:18 INFO - 'SHELL': '/bin/bash', 17:13:18 INFO - 'SHLVL': '1', 17:13:18 INFO - 'TERM': 'linux', 17:13:18 INFO - 'TMOUT': '86400', 17:13:18 INFO - 'USER': 'cltbld', 17:13:18 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:18 INFO - '_': '/tools/buildbot/bin/python'} 17:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:13:18 INFO - Running setup.py (path:/tmp/pip-5I2_5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:13:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:13:18 INFO - Running setup.py (path:/tmp/pip-zXkRXn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:13:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:13:18 INFO - Running setup.py (path:/tmp/pip-GTYd49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:13:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:13:18 INFO - Running setup.py (path:/tmp/pip-vj59WK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:13:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:13:18 INFO - Running setup.py (path:/tmp/pip-cm8ZrP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:13:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:13:18 INFO - Running setup.py (path:/tmp/pip-MwYIu8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:13:19 INFO - Running setup.py (path:/tmp/pip-8xXRn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:13:19 INFO - Running setup.py (path:/tmp/pip-9MypgH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:13:19 INFO - Running setup.py (path:/tmp/pip-r7jwNN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:13:19 INFO - Running setup.py (path:/tmp/pip-Xl0mOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:13:19 INFO - Running setup.py (path:/tmp/pip-wSIlAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:13:19 INFO - Running setup.py (path:/tmp/pip-avKtK7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:13:19 INFO - Running setup.py (path:/tmp/pip-zostTT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:13:19 INFO - Running setup.py (path:/tmp/pip-S7iut1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:13:19 INFO - Running setup.py (path:/tmp/pip-Lysxon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:13:19 INFO - Running setup.py (path:/tmp/pip-pI6a7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:13:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:13:19 INFO - Running setup.py (path:/tmp/pip-1qMG9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:13:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:19 INFO - Running setup.py install for manifestparser 17:13:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:13:19 INFO - Running setup.py install for mozcrash 17:13:19 INFO - Running setup.py install for mozdebug 17:13:20 INFO - Running setup.py install for mozdevice 17:13:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Running setup.py install for mozfile 17:13:20 INFO - Running setup.py install for mozhttpd 17:13:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Running setup.py install for mozinfo 17:13:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Running setup.py install for mozInstall 17:13:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Running setup.py install for mozleak 17:13:20 INFO - Running setup.py install for mozlog 17:13:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Running setup.py install for moznetwork 17:13:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:13:20 INFO - Running setup.py install for mozprocess 17:13:21 INFO - Running setup.py install for mozprofile 17:13:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:13:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:13:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:13:21 INFO - Running setup.py install for mozrunner 17:13:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:13:21 INFO - Running setup.py install for mozscreenshot 17:13:21 INFO - Running setup.py install for moztest 17:13:21 INFO - Running setup.py install for mozversion 17:13:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:13:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:21 INFO - Cleaning up... 17:13:21 INFO - Return code: 0 17:13:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:21 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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:13:21 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 17:13:21 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 17:13:21 INFO - Using env: {'DISPLAY': ':0', 17:13:21 INFO - 'HOME': '/home/cltbld', 17:13:21 INFO - 'LANG': 'en_US.UTF-8', 17:13:21 INFO - 'LANGUAGE': 'en_US:en', 17:13:21 INFO - 'LOGNAME': 'cltbld', 17:13:21 INFO - 'MAIL': '/var/mail/cltbld', 17:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:21 INFO - 'MOZ_NO_REMOTE': '1', 17:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:21 INFO - 'NO_EM_RESTART': '1', 17:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:13:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:13:21 INFO - 'SHELL': '/bin/bash', 17:13:21 INFO - 'SHLVL': '1', 17:13:21 INFO - 'TERM': 'linux', 17:13:21 INFO - 'TMOUT': '86400', 17:13:21 INFO - 'USER': 'cltbld', 17:13:21 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:21 INFO - '_': '/tools/buildbot/bin/python'} 17:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:13:21 INFO - Running setup.py (path:/tmp/pip-8SNsEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 17:13:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:13:21 INFO - Running setup.py (path:/tmp/pip-NzLXmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:13: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)) 17:13:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:13:21 INFO - Running setup.py (path:/tmp/pip-9Tpmx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:13:22 INFO - Running setup.py (path:/tmp/pip-3vlqni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:13:22 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)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:13:22 INFO - Running setup.py (path:/tmp/pip-gL6QOV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:13:22 INFO - Running setup.py (path:/tmp/pip-EtHweL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:13:22 INFO - Running setup.py (path:/tmp/pip-67xmUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:13:22 INFO - Running setup.py (path:/tmp/pip-ZarXFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:13:22 INFO - Running setup.py (path:/tmp/pip-AkX0un-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:13:22 INFO - Running setup.py (path:/tmp/pip-rORSwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:13:22 INFO - Running setup.py (path:/tmp/pip-7lJbCI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:13:22 INFO - Running setup.py (path:/tmp/pip-Ieeerb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:13:22 INFO - Running setup.py (path:/tmp/pip-FXhWmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:13:22 INFO - Running setup.py (path:/tmp/pip-JCSp74-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:13:22 INFO - Running setup.py (path:/tmp/pip-R4Jg7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:13:22 INFO - Running setup.py (path:/tmp/pip-lPs0_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:13: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)) 17:13:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:13:22 INFO - Running setup.py (path:/tmp/pip-mgNNBC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 17:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:38 INFO - Downloading blessings-1.6.tar.gz 17:13:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:38 INFO - Installing collected packages: blessings 17:13:38 INFO - Running setup.py install for blessings 17:13:38 INFO - Successfully installed blessings 17:13:38 INFO - Cleaning up... 17:13:38 INFO - Return code: 0 17:13:38 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:13:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:13:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:13:39 INFO - Reading from file tmpfile_stdout 17:13:39 INFO - Current package versions: 17:13:39 INFO - argparse == 1.2.1 17:13:39 INFO - blessings == 1.6 17:13:39 INFO - blobuploader == 1.2.4 17:13:39 INFO - docopt == 0.6.1 17:13:39 INFO - manifestparser == 1.1 17:13:39 INFO - mozInstall == 1.12 17:13:39 INFO - mozcrash == 0.17 17:13:39 INFO - mozdebug == 0.1 17:13:39 INFO - mozdevice == 0.48 17:13:39 INFO - mozfile == 1.2 17:13:39 INFO - mozhttpd == 0.7 17:13:39 INFO - mozinfo == 0.9 17:13:39 INFO - mozleak == 0.1 17:13:39 INFO - mozlog == 3.1 17:13:39 INFO - moznetwork == 0.27 17:13:39 INFO - mozprocess == 0.22 17:13:39 INFO - mozprofile == 0.28 17:13:39 INFO - mozrunner == 6.11 17:13:39 INFO - mozscreenshot == 0.1 17:13:39 INFO - mozsystemmonitor == 0.0 17:13:39 INFO - moztest == 0.7 17:13:39 INFO - mozversion == 1.4 17:13:39 INFO - psutil == 3.1.1 17:13:39 INFO - requests == 1.2.3 17:13:39 INFO - wsgiref == 0.1.2 17:13:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:13:39 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')]} 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:39 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')]} 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:39 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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:13:39 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 17:13:39 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 17:13:39 INFO - Using env: {'DISPLAY': ':0', 17:13:39 INFO - 'HOME': '/home/cltbld', 17:13:39 INFO - 'LANG': 'en_US.UTF-8', 17:13:39 INFO - 'LANGUAGE': 'en_US:en', 17:13:39 INFO - 'LOGNAME': 'cltbld', 17:13:39 INFO - 'MAIL': '/var/mail/cltbld', 17:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:39 INFO - 'MOZ_NO_REMOTE': '1', 17:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:39 INFO - 'NO_EM_RESTART': '1', 17:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:13:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:13:39 INFO - 'SHELL': '/bin/bash', 17:13:39 INFO - 'SHLVL': '1', 17:13:39 INFO - 'TERM': 'linux', 17:13:39 INFO - 'TMOUT': '86400', 17:13:39 INFO - 'USER': 'cltbld', 17:13:39 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:39 INFO - '_': '/tools/buildbot/bin/python'} 17:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 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)) 17:13:39 INFO - Cleaning up... 17:13:39 INFO - Return code: 0 17:13:39 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:13:39 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')]} 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:39 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')]} 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:39 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 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:13:39 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 17:13:39 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 17:13:39 INFO - Using env: {'DISPLAY': ':0', 17:13:39 INFO - 'HOME': '/home/cltbld', 17:13:39 INFO - 'LANG': 'en_US.UTF-8', 17:13:39 INFO - 'LANGUAGE': 'en_US:en', 17:13:39 INFO - 'LOGNAME': 'cltbld', 17:13:39 INFO - 'MAIL': '/var/mail/cltbld', 17:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:39 INFO - 'MOZ_NO_REMOTE': '1', 17:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:39 INFO - 'NO_EM_RESTART': '1', 17:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:13:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:13:39 INFO - 'SHELL': '/bin/bash', 17:13:39 INFO - 'SHLVL': '1', 17:13:39 INFO - 'TERM': 'linux', 17:13:39 INFO - 'TMOUT': '86400', 17:13:39 INFO - 'USER': 'cltbld', 17:13:39 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:39 INFO - '_': '/tools/buildbot/bin/python'} 17:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:39 INFO - Downloading/unpacking jsonschema 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:39 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 17:13:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:47 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:47 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:47 INFO - warning: no files found matching '*.txt' 17:13:47 INFO - no previously-included directories found matching 'build' 17:13:47 INFO - no previously-included directories found matching 'dist' 17:13:47 INFO - no previously-included directories found matching '.git*' 17:13:47 INFO - Installing collected packages: jsonschema, functools32 17:13:47 INFO - Running setup.py install for functools32 17:13:47 INFO - warning: no files found matching '*.txt' 17:13:47 INFO - no previously-included directories found matching 'build' 17:13:47 INFO - no previously-included directories found matching 'dist' 17:13:47 INFO - no previously-included directories found matching '.git*' 17:13:47 INFO - Successfully installed jsonschema functools32 17:13:47 INFO - Cleaning up... 17:13:48 INFO - Return code: 0 17:13:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6b228dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d66b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, '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': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', '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 17:13:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:13:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:13:48 INFO - Using env: {'DISPLAY': ':0', 17:13:48 INFO - 'HOME': '/home/cltbld', 17:13:48 INFO - 'LANG': 'en_US.UTF-8', 17:13:48 INFO - 'LANGUAGE': 'en_US:en', 17:13:48 INFO - 'LOGNAME': 'cltbld', 17:13:48 INFO - 'MAIL': '/var/mail/cltbld', 17:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:48 INFO - 'MOZ_NO_REMOTE': '1', 17:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:48 INFO - 'NO_EM_RESTART': '1', 17:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:13:48 INFO - 'PWD': '/builds/slave/test-pgo', 17:13:48 INFO - 'SHELL': '/bin/bash', 17:13:48 INFO - 'SHLVL': '1', 17:13:48 INFO - 'TERM': 'linux', 17:13:48 INFO - 'TMOUT': '86400', 17:13:48 INFO - 'USER': 'cltbld', 17:13:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:48 INFO - '_': '/tools/buildbot/bin/python'} 17:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:48 INFO - Downloading/unpacking flake8 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:51 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 17:13:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:52 INFO - no previously-included directories found matching 'docs/_build' 17:13:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:52 INFO - Running setup.py install for pep8 17:13:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:52 INFO - no previously-included directories found matching 'docs/_build' 17:13:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:13:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:52 INFO - Cleaning up... 17:13:52 INFO - Return code: 0 17:13:52 INFO - Running post-action listener: _resource_record_post_action 17:13:52 INFO - Running post-action listener: _start_resource_monitoring 17:13:52 INFO - Starting resource monitoring. 17:13:52 INFO - ##### 17:13:52 INFO - ##### Running install step. 17:13:52 INFO - ##### 17:13:52 INFO - Running pre-action listener: _resource_record_pre_action 17:13:52 INFO - Running main action method: install 17:13:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:13:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:13:52 INFO - Reading from file tmpfile_stdout 17:13:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:13:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:13:52 INFO - Reading from file tmpfile_stdout 17:13:52 INFO - Output received: 17:13:52 INFO - Usage: mozinstall [options] installer 17:13:52 INFO - Options: 17:13:52 INFO - -h, --help show this help message and exit 17:13:52 INFO - -d DEST, --destination=DEST 17:13:52 INFO - Directory to install application into. [default: 17:13:52 INFO - "/builds/slave/test-pgo"] 17:13:52 INFO - --app=APP Application being installed. [default: firefox] 17:13:52 INFO - mkdir: /builds/slave/test-pgo/build/application 17:13:52 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'] 17:13:52 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 17:14:09 INFO - Reading from file tmpfile_stdout 17:14:09 INFO - Output received: 17:14:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:14:09 INFO - Running post-action listener: _resource_record_post_action 17:14:09 INFO - ##### 17:14:09 INFO - ##### Running run-tests step. 17:14:09 INFO - ##### 17:14:09 INFO - Running pre-action listener: _resource_record_pre_action 17:14:09 INFO - Running main action method: run_tests 17:14:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:14:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:14:09 INFO - Python 2.7.3 17:14:09 INFO - Return code: 0 17:14:09 INFO - grabbing minidump binary from tooltool 17:14: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')]} 17:14:09 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 0x20d11d0>, '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 0x20d4750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:14:09 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 17:14:09 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 17:14:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:14:09 INFO - Return code: 0 17:14:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:14:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:14:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:14:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:14:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:14:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:14:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:14:10 INFO - Return code: 0 17:14:10 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/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 17:14:10 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/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 17:14:10 INFO - Using env: {'DISPLAY': ':0', 17:14:10 INFO - 'HOME': '/home/cltbld', 17:14:10 INFO - 'LANG': 'en_US.UTF-8', 17:14:10 INFO - 'LANGUAGE': 'en_US:en', 17:14:10 INFO - 'LOGNAME': 'cltbld', 17:14:10 INFO - 'MAIL': '/var/mail/cltbld', 17:14:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:14:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:10 INFO - 'MOZ_NO_REMOTE': '1', 17:14:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:10 INFO - 'NO_EM_RESTART': '1', 17:14:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:10 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:14:10 INFO - 'SHELL': '/bin/bash', 17:14:10 INFO - 'SHLVL': '1', 17:14:10 INFO - 'TERM': 'linux', 17:14:10 INFO - 'TMOUT': '86400', 17:14:10 INFO - 'USER': 'cltbld', 17:14:10 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098', 17:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:10 INFO - '_': '/tools/buildbot/bin/python'} 17:14:10 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/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 17:14:10 INFO - mozversion application_buildid: 20160322143109 17:14:10 INFO - mozversion application_changeset: abfac0d05b79b49597d5fa8d4ce87caf4caaff8e 17:14:10 INFO - mozversion application_display_name: Nightly 17:14:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:14:10 INFO - mozversion application_name: Firefox 17:14:10 INFO - mozversion application_remotingname: firefox 17:14:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:14:10 INFO - mozversion application_vendor: Mozilla 17:14:10 INFO - mozversion application_version: 48.0a1 17:14:10 INFO - mozversion platform_buildid: 20160322143109 17:14:10 INFO - mozversion platform_changeset: abfac0d05b79b49597d5fa8d4ce87caf4caaff8e 17:14:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:14:10 INFO - mozversion platform_version: 48.0a1 17:14:10 INFO - using testdate: 1458692050 17:14:10 INFO - actual date: 1458692050 17:14:10 INFO - starting webserver on 'localhost:35963' 17:14:10 INFO - SUITE-START | Running 2 tests 17:14:10 INFO - TEST-START | dromaeo_css 17:14:10 INFO - operating with platform_type : linux_ 17:14:10 INFO - Initialising browser for dromaeo_css test... 17:14:10 INFO - TEST-INFO | started process 26985 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqa3z2E/profile http://localhost:35963/getInfo.html) 17:14:14 INFO - PROCESS | 26985 | __metrics Screen width/height:1600/1200 17:14:14 INFO - PROCESS | 26985 | colorDepth:24 17:14:14 INFO - PROCESS | 26985 | Browser inner width/height: 1024/697 17:14:14 INFO - PROCESS | 26985 | __metrics 17:14:15 ERROR - PROCESS | 26985 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:14:16 INFO - TEST-INFO | 26985: exit 0 17:14:16 INFO - Browser initialized. 17:14:16 INFO - Running cycle 1/1 for dromaeo_css test... 17:14:16 INFO - TEST-INFO | started process 27079 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqa3z2E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:27 INFO - PROCESS | 27079 | RSS: Main: 155799552 17:14:27 INFO - PROCESS | 27079 | 17:15:18 INFO - PROCESS | 27079 | 1458692118507 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] 17:17:25 INFO - PROCESS | 27079 | Cycle 1(1): loaded http://localhost:35963/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35963/tests/dromaeo/cssquery-ext.html) 17:17:26 INFO - PROCESS | 27079 | RSS: Main: 268275712 17:17:26 INFO - PROCESS | 27079 | 17:20:29 INFO - PROCESS | 27079 | Cycle 1(1): loaded http://localhost:35963/tests/dromaeo/cssquery-ext.html (next: http://localhost:35963/tests/dromaeo/cssquery-jquery.html) 17:20:29 INFO - PROCESS | 27079 | RSS: Main: 242970624 17:20:29 INFO - PROCESS | 27079 | 17:23:31 INFO - PROCESS | 27079 | Cycle 1(1): loaded http://localhost:35963/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35963/tests/dromaeo/cssquery-mootools.html) 17:23:32 INFO - PROCESS | 27079 | RSS: Main: 233107456 17:23:32 INFO - PROCESS | 27079 | 17:26:33 INFO - PROCESS | 27079 | Cycle 1(1): loaded http://localhost:35963/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35963/tests/dromaeo/cssquery-prototype.html) 17:26:34 INFO - PROCESS | 27079 | RSS: Main: 222294016 17:26:34 INFO - PROCESS | 27079 | 17:29:37 INFO - PROCESS | 27079 | Cycle 1(1): loaded http://localhost:35963/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35963/tests/dromaeo/cssquery-yui.html) 17:29:37 INFO - PROCESS | 27079 | RSS: Main: 219471872 17:29:37 INFO - PROCESS | 27079 | 17:32:39 INFO - PROCESS | 27079 | Cycle 1(1): loaded http://localhost:35963/tests/dromaeo/cssquery-yui.html (next: http://localhost:35963/tests/dromaeo/cssquery-dojo.html) 17:32:40 INFO - PROCESS | 27079 | RSS: Main: 271564800 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | __start_tp_report 17:32:40 INFO - PROCESS | 27079 | _x_x_mozilla_page_load 17:32:40 INFO - PROCESS | 27079 | _x_x_mozilla_page_load_details 17:32:40 INFO - PROCESS | 27079 | |i|pagename|runs| 17:32:40 INFO - PROCESS | 27079 | |0;dojo.html;3050.2221933406977;3064.693530646934;3103.270731378127;3108.9378212435768;3131.32676474558;5139.049275883964;5216.5565926896215;5221.138512145496;5244.370675518939;5338.733063346836;5331.893362132755;5360.678359298445;5367.677939323634;5378.0857254266775;5382.784688612461;4748.145333839908;4768.165571025065;4787.353707249512;4874.073925954075;4883.511648835123;4648.511906249846;4821.90356192876;4854.708717476963;4892.094962431944;4917.704937703749;4739.573438390561;4761.309610106532;4782.30656554801;4803.759812009385;4842.394700662418;4769.95230047702;4771;4794.113089078497;4796.376471058775;4831.154547954129;4631.004334068158;4716.151092803294;4796.952030479685;4815.205491093965;4830.154722923475;5209.531142197183;5233.21501774733;5236.764345604457;5248.0553500369915;5254.343207099113;5705.400932902068;5717.42825717425;5721.199032135462;5721.971390143064;5729.226554415142;5539.778408863641;5653.717314134318;5694.886102277973;5707.315122185364;5739.196512488255;5273.578113750891;5344.331958505187;5346.331708536433;5346.385165705955;5347.679139251657;5851.531877449879;5870.970645146833;5872.647641141545;5877.206577112121;5879.470847623649;5462.180672899097;5578.693171875505;5610;5610.635308704921;5664;5627.240322556402;5628.60599758013;5629.859253518613;5632.774689012475;5659.179418984224;5456.345238571397;5629.380768115504;5634.295713035871;5640.323161220597;5651.406602306699;5657.688827114466;5683.886322273532;5691.800786972436;5693.402192769782;5735.254416925773;4320.524742278347;4328.394024836525;4329.523752387235;4340.392345071693;4371.388005679208;3774.6791522720328;3826.942595861064;3853.1523064925673;3899.922001559953;3908.355121404936;5407.621466497308;5438.401775804658;5441.59188060897;5451;5480.095784195642;5694.4590263924865;5700.23046888673;5701.486866182064;5704.800331988444;5705.5720820938595;5235.790568377299;5414.83755487336;5425.7829686812875;5484.698341591171;5503.3395992481155;4935.136351138608;4940.802367905316;4959.2809042688605;4959.727215003138;4973.55238028572;5984.640921544721;5998.340182579913;6002.939970600325;6003.729832157564;6058.212432383762;5599.888002239851;5693.28833895763;5758.539316854558;5768.451997060272;5792.884142317214;5951.851203719942;5958.582899197015;5962.970185149046;5971.790987315423;5976.282846058501;5613.550915926798;5614.90509350689;5617.269754931833;5618.044932361427;5619.747111379916;5575.275214222125;5612.7754889803955;5645.068563686946;5657.915131272952;5704.030314846569;5568.749406276646;5582.051051321204;5591.748371323219;5599.384067752462;5601.187827765033;5401.837944861661;5493.025205052863;5542.667439953616;5545.805896793593;5556.16657501378;5467.917981230205;5493.313335833021;5517.144842549411;5520.834374968757;5560.02699527573;5579.804706835242;5588.133839254922;5614.466625670555;5618.073017951992;5635.549156067423;5336.199570064521;5479.753411096431;5480.451954804487;5511.338639363302;5567.916481252865 17:32:40 INFO - PROCESS | 27079 | |1;ext.html;548.5035901626256;556.9526590239827;571.1689491789447;574.0757380617206;591.3701907468547;27337.863310683442;27576.310592235204;27754.30614234645;27799.305017374576;37790.43314350287;40334.59665403345;40668.59331406685;40679.796601016955;40914.386284205764;40985.79507102468;8565.571721413935;8743.038265790758;8750.649974001064;8754.649814007464;8758.56207189638;8578.44240124393;8588.227059564639;8704.04255531891;8707.825843483126;8710.956445217766;8670.176333248332;8785;8796.252318552899;8796.824063518727;9065.95467022664;8887.68893088742;8963.820723585492;8969.461832290084;8970.730878073635;8971.910280897206;8799;8900.643974241022;8938.1508756668;8954.059823718546;8955.955220223923;40006.59993400058;40400.59599403998;40479.7976010121;40494.1901161978;40503.18993620141;3505.2814173094453;3594.0475773919934;3826.617338266151;3897.883063508071;4383.64930805538;30228.395432091456;30416.087517374515;30483;30544.236394090105;30984.225394365098;4352.455943007124;4398.73607583546;4408.713433626836;4575.107853968478;4598.678092533524;328561;329896;332109;332181;333151;57609;58832.41167588355;59014.40985590175;59036;59060;61049.38950610526;61327.38672613306;61364;61385.77228455495;61695.6915215421;16858.747118793228;17082.743758843626;17086;17092.91453542749;17095.401660941807;13193.40629671667;13241.3379331035;13255.204687718768;13269.402876870565;13271.800922986164;17074.48776536706;18819.341323053628;18845.340413085476;18910;18993.715094273597;7232.349088581947;7474.813129671802;7532.849343013109;7557.508761930457;7583;1065.7548763784218;1110.1826429509313;1114.3146964616865;1132.7904337697553;1159.3739380734478;30504.38991220163;30849.845750771103;31189.22026949299;31380.843095784832;31810.522842157385;1134.8978591926766;1153.0084127650214;1184.1231647838101;1195.7190060335813;1242.9005679545614;15758.212089395485;15930.840691593168;16056.919715401582;16108.27512761905;16351.672966540602;394849;397116;400570;400983;401211;55387;55522.44477555253;55630.72184639051;55695;55713;1196.8503937007874;1416.185693226399;1427.4290283886528;1430.7138572285585;1431.3773508523825;25504.2348729531;26203;26950.59574106351;27134.592981104903;27876;42747;42862.57137428711;43241;43356.566434335255;43378.13243735045;248651;254193;255221;255333;255636;29066;34452.31095378028;35041.29917401689;35454.25105248694;35996.64003359933;44708;44734.77632611816;45052.774736126106;45206.32190517079;45311.773441133904;36914.26171476609;37096.44355334618;37167;37786.24427511379;38269.4259586112;36580.45129323009;37252.25495490129;38159;38281.23437531178;38689;38690;38843.417348739225;39270.214595708494;39406;39508;32057.198570035936;33594.49608255829;33883.36864301466;34073;34306.65693343035;26636.7336326642;26847.86576067185;26973.595396069468;26978.595321070592;27035.459290814466 17:32:40 INFO - PROCESS | 27079 | |2;jquery.html;377.3057574063722;380.3306181121226;381.8033712637991;385.35645472061657;386.49176333121943;17120.999999999985;18160.727589086157;18225.81774182258;18522.44432667019;18550.907245463786;16965.3213871445;17703;18088.909555452203;18105;18120.909395453004;5316.38861530925;5460.918086228709;5481.671099734029;5485.177223416479;5488.286522752037;3918.725689201757;5421.186821976696;5851.297844258695;6085.543584231178;6088.908666370008;6028.21633187685;6035.366286539916;6054.455099041085;6070;6071.1803906472505;5759.4528519790765;5908.822735317947;5915.201447804534;5935.139404786303;5973.342932277446;3494.2312691207894;5061.746912654353;5229.947700523022;5231.607629427808;5232.189010703347;20241.291554795513;20289.28987485431;20380.184792608277;22063.66904496434;22085.668714969288;2329.650552417134;2547.630593563923;2562.8077894157827;2727.9454410911867;3060.1737530866762;9812.264080194014;9881;9951.353162044445;10130.189584833195;13714.725705485835;1896.5543097372106;1968.173367185771;2002.149086638173;2014.6575082236054;2035.9287424940205;61059.389406105816;63174.0523892142;63323.366766332205;68558;71651.04361954756;10839.241253112206;10852.837207441895;11051.336919784839;11066.114710823114;11115.44422778874;14312.212828294336;14332.641683957985;14416.495422660157;14427.49503767363;14429.20639364845;8228.547429891414;8472.068072512018;8479.618417171243;8587.441816281922;8587.656493740305;8351.20663536963;8395.916040839636;8400.033996090406;8452.450590711584;8531.274841638406;4686.039361930864;4698.694584851974;4704.976475117603;4762.14281429346;4811.27830825379;1783.5273652482103;1867.7011678131435;3151.2909595341325;3169.4770362890326;3191.3617276544783;907.7186072317471;1030.8299130643509;1033.121846430543;1063.7659714862718;1081.9513121909533;17844.643107137785;18103.366382176562;18186.45440636783;18576.349827756236;18737.25050997972;981.6711401680517;1012.1851909213154;1021.22897212604;1039.9064084232455;1051.9263651544472;10275.486225688686;10396.48017599117;10403.947980260202;10404.219683523766;10569.682909512727;485628;486063;486362;495336.5233173811;503160;78642.6067869657;80843;83293.58353208317;83314.58342708247;83627;1014.7108074198966;1034.2656713733184;1053.6048981631889;1061.6337363609696;1062.0812996757904;16227.675446491241;16318.918405407898;16345.67308653844;16420.67158656796;16450;36387;36962;37785;38422.399428706696;39149;54283.18575221454;54359;54442.18336725031;54525;54685;8302.626381812712;8364.205400486944;8377.078521362768;8395.874061888955;8419.915800841913;12291.385430728249;12513.374331283581;12557.121001529806;12577.308248046445;12586.24482531051;10433.426161560883;10689.572417103229;10834.891651083388;10860.239783215098;11085;10884.51019704131;11003.064739497233;11065.170112241774;11187.440627968406;11244.381559014333;11036.613718519813;11139.498722557666;11287.887121129012;11381.203315768147;11407.144464165054;8060.83878322442;8126.634301456331;8215.342772578299;8267.255946964802;11201.551937922392;10913.890861091288;10948.178886583379;10997.835032474359;11263.605773797877;11408.372539510407 17:32:40 INFO - PROCESS | 27079 | |3;mootools.html;1323.3383308345826;1533.47095252138;1550.2403822127153;1729.9221535030922;1848.2237460266688;7812;7987.5207487550715;8008.759737207886;8011.799705007378;8015.7194498192575;7867.606619669023;8029.156938521459;8035.6785728570785;8040.437169398145;8043.396745244116;1964.2241314680693;2010.035183112107;2335.6730057791924;2340.801031912281;2367.5856725073045;2384.213209640823;2396.436837343223;2396.4488167721433;2396.6285225789943;2396.9760302397012;2303.8387312888103;2308.607536718762;2313.6992191015142;2365.95268094638;2366.763323667628;2323.8605683659034;2341.6487526870937;2354.0701422937927;2354.2701762453694;2389.438481956739;2349.1777877742825;2356.5051339218785;2389.319044072431;2391.1272385579314;2398.6881705378364;7895.171007044235;7903.446758726892;7937.603119843985;7949.7217597383815;7962;5119.385673719177;5236.293100431431;5241.8165364212455;5242.97378513105;5244.213367994793;3302.3230237801195;3353.3460975109865;3394.6096198937194;3429.331280400323;3447.7414193935556;1104.6851647280487;1113.8162203236457;1120.3445984099312;1139.4132022008673;1149.0233301693577;11342.943285283603;11357.545698172064;11370.374629395379;11371.829422558669;11396.145289103268;4621;4639.884002899955;4720.527947205252;4735.95264047362;4736.621070314367;9797.608095676236;9799.216062714966;9799.461029643295;9805.950970245103;9810.117089461983;5231.241469986907;5264.815731449381;5270.657407268592;5274.26160337553;5277.973610131925;3973.5827738087664;4488.192125417456;4504.504504504502;4619.561141691601;4821.63837712173;3915.8237879295502;3997.040710229582;4013.3578627419474;4048.0891799344913;4065.7357271777832;1275.8660340664283;1297.1049975516862;1306.072688391234;1312.061875758818;1313.9277339746216;1356.9118007329491;1357.9049466537444;1394.623451668044;1398.5874167120724;1423.8789702875372;7781.727639532589;7825.882611760828;7844.686212551548;7866.72466463671;7909;486.0837321648718;489.6034212288058;489.73799017525454;499.1564256406661;501.09552258174347;6059.272887253558;6129.172561704202;6154.415330543591;6157.445829875243;6220.066989951543;9893.45585992763;10069.748256293651;10092.444915529717;10165.13596344319;10185.847212291821;9816;9974.320586164878;10011.649592264235;10019.549120289605;10060.547275372626;7344.559326440431;7400.555966642019;7413.258674132544;7482.102147742197;7487.438442116863;7443.739469118555;7479.925200748141;7524.322810947041;7526.5107767994905;7530.774076777706;8777.03452620224;8911.2425443838;8980.775480613036;8988.235999940078;9008.32437567172;9205.30960177976;9270.53647317645;9295.581698823435;9318.347715659838;9371.250299975849;6398.424141827071;6546.149000629887;7104.928950710633;7266.200717920919;7328.267173282629;7967.32277756374;7979.16218797018;7991.920080799117;8030.156833532628;8032.317253033558;7155;7381.04046473955;7393.963030184815;7467.477276590586;7470.775876723707;7048.224695283618;7122.643867806485;7147.493867842761;7156;7196.244394338519;7364.0426744522865;7456.813579660552;7466.25337466249;7471;7483.027206463125;6693.631850248088;6698.531102822755;6741.662916854039;6759.729610815512;6798.456123510206;6822.727090916308;6968.930310697031;6985.1617805863625;6985.965070174617;6995.055667484824 17:32:40 INFO - PROCESS | 27079 | |4;prototype.html;335.59895924370386;337.50218427818953;337.822643112366;339.79272643687347;346.57890662844625;5831.212786273852;5841.649501029936;5848.210491583635;5863.824085277443;5867.794627188049;5818.1272809078655;5821.767129314822;5824.592278540504;5824.679642619654;5839.678817665027;4298.7205831621;4392.890177745566;4447.888802779924;4473.99335149592;4480.731156130626;4450.109978004412;4460.955390446086;4465.799039043251;4477.283634618461;4482.282834746441;4411.911761764763;4453.354263631772;4475.328700694889;4480.551944805526;4483.887902802439;4246.405503229535;4398.780060996969;4470.9105817883465;4480.48474425442;4506.526814684476;3960.089179488734;3964.7224694271413;3966.6430021297933;3966.8809935701975;3972.980135099306;5647.0964645656495;5657.6322539035245;5667.829965101054;5668;5681.204631351614;5265.6840589564745;5266.183741520071;5271.710055946922;5272.156454967225;5277.261183434322;6192.535559832985;6198.566100372976;6198.752049917998;6199.349068347804;6205.410486003822;4183.707140500166;4346.717463364903;4354.129174165148;4440.045390241082;4441.71128876622;6453.257875344301;6477.48180145592;6510.674466276667;6530.804075877779;6530.93469065308;4465.106978604292;4468.061707041557;4472;4475.149721552894;4476.395686582335;4529.886752831206;4531.116432295671;4532.9093418132115;4533.410656614619;4535.387722657399;5212.270282160501;5215.947840521546;5215.973920130375;5219.660722053054;5227.18978558324;6088.939110608926;6288.056791481315;6290.370962903673;6292.685365731695;6297.992321228581;1572.6540161164526;1579.676166385888;1588.5313832419463;1589.2927647196886;1594.8484893935058;1011.7369483934231;1063.7925604507047;1065.2649671726483;1074.8763892152504;1090.2095980414135;6008.188894499274;6008.279006519158;6049.122877182784;6052.788152414644;6059.394060593993;6369.522285828489;6377.8519866424485;6383.904241436382;6391;6397;6034.306054803666;6037.969810150921;6041.72812223451;6042.6978651067275;6052.818415447544;3400.3879301725433;3424.280901010766;3433.1931995980926;3436.244026314207;3436.381451338783;6484.643344616092;6593.703283352164;6643.800685979331;6645.302243264484;6652.401283884474;6477.935220647827;6518.641474718936;6519.771807986793;6534.281229064799;6534.673266336664;6558.573692710054;6613.173353330833;6615.76844810439;6631.767888123893;6633.6019838809825;6333.2716737575765;6335.334789847;6335.714892829741;6336;6349.396807303298;6118.112873633388;6274.46667033289;6278.434940855345;6284.120223168851;6340.175777149126;6601.834954125993;6630.104935833793;6632.834179145367;6635.900461493178;6655.767048153291;4454.175977444183;4456.041950980555;4458.933116003327;4467.486239082417;4473.2842745160615;6342.080398342122;6350.079238510298;6356.078368636429;6359.268684101387;6367.076773867856;6207.596506227081;6208.192934918432;6212.720427580679;6214.130021796862;6218.657973811484;6041.029517885962;6126.632402055891;6176.7838125665385;6179.567430279837;6182.876342473035;6061.7575296987625;6079.1793107931635;6085.878282434415;6086.391360863879;6090.786822461193;6206.937930620636;6210.4100110489435;6215.316315205414;6218.347073557211;6232.096346029891;5904.439078287556;6037.305709843425;6068.9089663654195;6082.513398928164;6083.361247069171 17:32:40 INFO - PROCESS | 27079 | |5;yui.html;826.06241915426;837.2924878477684;837.6942416018154;839.6347588798877;845.2097289034753;12905.419256133473;12969.935150324236;12991.350432478386;13045.608631741039;13098;13099;13122.606321810337;13196.34018299086;14096.64758381041;14218.71562568748;826.8635675113599;830.8379865926147;838.9832203355929;839.559231403515;842.3345557009955;829.4235506323078;830.7383174300077;831.7296878514477;832.3507664022043;833.9332853371747;870.4037734152095;871.1593312453481;871.8125602995354;871.9346049046316;872.2193636695185;866.7226487523994;867.301822033263;868.5179725252482;870.3907264914553;871.3247233394106;638.3425072175667;639.5299454900644;639.5331408072087;639.9680015999181;640.2956747577674;13215.405306761219;13241.073124881263;13279;13394.129381590263;13413.932930335286;12975.416106275241;12992;13016.739665206644;13130.212187268698;13209;10676.839847402296;10807.729806754895;10826.945865270623;10916.617918372898;11006;3834.3098242316373;3835.7314987950854;3863.304605171068;3889.572147063821;3943.2310699413624;46254.53745462536;52917;59604.40395596032;60222.39777602212;60438.39561604416;10694.94652526748;10840.728981775519;10903.727406814734;10919.563217471372;11139;18719.719204211946;18781;18785.06074696287;18790.436286911416;18848.52878678044;8518.616662250213;8639.740807775777;8644;8707.956460217658;8836.734897952943;4540.931886021713;4623.302201833976;4726.291056341576;4732.313814496879;4924.75376231187;3344.5317655528247;3368.9663103369144;3369.4777309517062;3373.730101591867;3380.7802492837886;588.0825911577953;606.3239487970969;608.7473698415197;609.2110716621985;614.1984709953554;668.4318329419954;673.8787018336649;679.341039191983;686.2382755141789;690.4303949241895;8281.917180828115;8312.21034001769;8456.577171141418;8562.357823163287;8652.760147527666;588.6850534963773;591.5947575910515;649.746598826458;659.7822718502882;668.3350066683681;3951.913223863403;4076.8165432555606;4080.2043601498017;4095.4675892133832;4125.834966601303;63448.68275658592;65354.67322663356;65398.346016539224;65470.67264663742;65551.67224163849;45231.321530177076;47695.761521192864;53410.46589534055;54100.729496352265;54987.72506137444;49947.50052499501;51337.229941550904;51573.48426515762;51825;52352.47647523552;8604.82790344177;8635.395522313378;8907.331950103899;8981.326400519856;9073.319501037317;35594;35648.4652730204;36452.81773591115;36519.81740091283;36729.816350918074;46645.30032049454;46668.299975501075;49592.256116159006;50456.74771626118;51047.48952510576;11619.244749091282;11731.41342932867;11755.588554400554;11799.292042477478;12203.328816915155;11953.282803031845;12140.392980351124;12235;12499.625011249676;12643.241405515699;10789.184043787582;11100.11199104086;11326.490307936327;11564.710882228012;11611.88388116108;11706.70733231676;11804.881951180721;11815.17293789461;11861.525538978689;11907.464164112462;11290.15323850698;11373.374464404536;11393;11561.88438115608;11734.530618775154;9323.627054917728;9376.3905346155;9449.196818270524;9513.381630194015;9588.37675551087;9244.352895297265;9374.25005999532;9469.621215151317;9481.857772133562;9561.282903782105 17:32:40 INFO - PROCESS | 27079 | __end_tp_report 17:32:40 INFO - PROCESS | 27079 | __start_cc_report 17:32:40 INFO - PROCESS | 27079 | _x_x_mozilla_cycle_collect,793 17:32:40 INFO - PROCESS | 27079 | __end_cc_report 17:32:40 INFO - PROCESS | 27079 | __startTimestamp1458693160056__endTimestamp 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | ------- Summary: start ------- 17:32:40 INFO - PROCESS | 27079 | Number of tests: 6 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | [#0] dojo.html Cycles:165 Average:5283.29 Median:5493.31 stddev:611.76 (11.1%) stddev-sans-first:588.02 17:32:40 INFO - PROCESS | 27079 | Values: 3050.2 3064.7 3103.3 3108.9 3131.3 5139.0 5216.6 5221.1 5244.4 5338.7 5331.9 5360.7 5367.7 5378.1 5382.8 4748.1 4768.2 4787.4 4874.1 4883.5 4648.5 4821.9 4854.7 4892.1 4917.7 4739.6 4761.3 4782.3 4803.8 4842.4 4770.0 4771.0 4794.1 4796.4 4831.2 4631.0 4716.2 4797.0 4815.2 4830.2 5209.5 5233.2 5236.8 5248.1 5254.3 5705.4 5717.4 5721.2 5722.0 5729.2 5539.8 5653.7 5694.9 5707.3 5739.2 5273.6 5344.3 5346.3 5346.4 5347.7 5851.5 5871.0 5872.6 5877.2 5879.5 5462.2 5578.7 5610.0 5610.6 5664.0 5627.2 5628.6 5629.9 5632.8 5659.2 5456.3 5629.4 5634.3 5640.3 5651.4 5657.7 5683.9 5691.8 5693.4 5735.3 4320.5 4328.4 4329.5 4340.4 4371.4 3774.7 3826.9 3853.2 3899.9 3908.4 5407.6 5438.4 5441.6 5451.0 5480.1 5694.5 5700.2 5701.5 5704.8 5705.6 5235.8 5414.8 5425.8 5484.7 5503.3 4935.1 4940.8 4959.3 4959.7 4973.6 5984.6 5998.3 6002.9 6003.7 6058.2 5599.9 5693.3 5758.5 5768.5 5792.9 5951.9 5958.6 5963.0 5971.8 5976.3 5613.6 5614.9 5617.3 5618.0 5619.7 5575.3 5612.8 5645.1 5657.9 5704.0 5568.7 5582.1 5591.7 5599.4 5601.2 5401.8 5493.0 5542.7 5545.8 5556.2 5467.9 5493.3 5517.1 5520.8 5560.0 5579.8 5588.1 5614.5 5618.1 5635.5 5336.2 5479.8 5480.5 5511.3 5567.9 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | [#1] ext.html Cycles:180 Average:49574.56 Median:38275.33 stddev:87599.15 (228.9%) stddev-sans-first:87767.55 17:32:40 INFO - PROCESS | 27079 | Values: 548.5 557.0 571.2 574.1 591.4 27337.9 27576.3 27754.3 27799.3 37790.4 40334.6 40668.6 40679.8 40914.4 40985.8 8565.6 8743.0 8750.6 8754.6 8758.6 8578.4 8588.2 8704.0 8707.8 8711.0 8670.2 8785.0 8796.3 8796.8 9066.0 8887.7 8963.8 8969.5 8970.7 8971.9 8799.0 8900.6 8938.2 8954.1 8956.0 40006.6 40400.6 40479.8 40494.2 40503.2 3505.3 3594.0 3826.6 3897.9 4383.6 30228.4 30416.1 30483.0 30544.2 30984.2 4352.5 4398.7 4408.7 4575.1 4598.7 328561.0 329896.0 332109.0 332181.0 333151.0 57609.0 58832.4 59014.4 59036.0 59060.0 61049.4 61327.4 61364.0 61385.8 61695.7 16858.7 17082.7 17086.0 17092.9 17095.4 13193.4 13241.3 13255.2 13269.4 13271.8 17074.5 18819.3 18845.3 18910.0 18993.7 7232.3 7474.8 7532.8 7557.5 7583.0 1065.8 1110.2 1114.3 1132.8 1159.4 30504.4 30849.8 31189.2 31380.8 31810.5 1134.9 1153.0 1184.1 1195.7 1242.9 15758.2 15930.8 16056.9 16108.3 16351.7 394849.0 397116.0 400570.0 400983.0 401211.0 55387.0 55522.4 55630.7 55695.0 55713.0 1196.9 1416.2 1427.4 1430.7 1431.4 25504.2 26203.0 26950.6 27134.6 27876.0 42747.0 42862.6 43241.0 43356.6 43378.1 248651.0 254193.0 255221.0 255333.0 255636.0 29066.0 34452.3 35041.3 35454.3 35996.6 44708.0 44734.8 45052.8 45206.3 45311.8 36914.3 37096.4 37167.0 37786.2 38269.4 36580.5 37252.3 38159.0 38281.2 38689.0 38690.0 38843.4 39270.2 39406.0 39508.0 32057.2 33594.5 33883.4 34073.0 34306.7 26636.7 26847.9 26973.6 26978.6 27035.5 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | [#2] jquery.html Cycles:180 Average:27861.12 Median:2645.38 stddev:80551.54 (3045.0%) stddev-sans-first:80751.07 17:32:40 INFO - PROCESS | 27079 | Values: 377.3 380.3 381.8 385.4 386.5 17121.0 18160.7 18225.8 18522.4 18550.9 16965.3 17703.0 18088.9 18105.0 18120.9 5316.4 5460.9 5481.7 5485.2 5488.3 3918.7 5421.2 5851.3 6085.5 6088.9 6028.2 6035.4 6054.5 6070.0 6071.2 5759.5 5908.8 5915.2 5935.1 5973.3 3494.2 5061.7 5229.9 5231.6 5232.2 20241.3 20289.3 20380.2 22063.7 22085.7 2329.7 2547.6 2562.8 2727.9 3060.2 9812.3 9881.0 9951.4 10130.2 13714.7 1896.6 1968.2 2002.1 2014.7 2035.9 61059.4 63174.1 63323.4 68558.0 71651.0 10839.2 10852.8 11051.3 11066.1 11115.4 14312.2 14332.6 14416.5 14427.5 14429.2 8228.5 8472.1 8479.6 8587.4 8587.7 8351.2 8395.9 8400.0 8452.5 8531.3 4686.0 4698.7 4705.0 4762.1 4811.3 1783.5 1867.7 3151.3 3169.5 3191.4 907.7 1030.8 1033.1 1063.8 1082.0 17844.6 18103.4 18186.5 18576.3 18737.3 981.7 1012.2 1021.2 1039.9 1051.9 10275.5 10396.5 10403.9 10404.2 10569.7 485628.0 486063.0 486362.0 495336.5 503160.0 78642.6 80843.0 83293.6 83314.6 83627.0 1014.7 1034.3 1053.6 1061.6 1062.1 16227.7 16318.9 16345.7 16420.7 16450.0 36387.0 36962.0 37785.0 38422.4 39149.0 54283.2 54359.0 54442.2 54525.0 54685.0 8302.6 8364.2 8377.1 8395.9 8419.9 12291.4 12513.4 12557.1 12577.3 12586.2 10433.4 10689.6 10834.9 10860.2 11085.0 10884.5 11003.1 11065.2 11187.4 11244.4 11036.6 11139.5 11287.9 11381.2 11407.1 8060.8 8126.6 8215.3 8267.3 11201.6 10913.9 10948.2 10997.8 11263.6 11408.4 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | [#3] mootools.html Cycles:180 Average:5762.59 Median:5276.12 stddev:3010.92 (57.1%) stddev-sans-first:3000.87 17:32:40 INFO - PROCESS | 27079 | Values: 1323.3 1533.5 1550.2 1729.9 1848.2 7812.0 7987.5 8008.8 8011.8 8015.7 7867.6 8029.2 8035.7 8040.4 8043.4 1964.2 2010.0 2335.7 2340.8 2367.6 2384.2 2396.4 2396.4 2396.6 2397.0 2303.8 2308.6 2313.7 2366.0 2366.8 2323.9 2341.6 2354.1 2354.3 2389.4 2349.2 2356.5 2389.3 2391.1 2398.7 7895.2 7903.4 7937.6 7949.7 7962.0 5119.4 5236.3 5241.8 5243.0 5244.2 3302.3 3353.3 3394.6 3429.3 3447.7 1104.7 1113.8 1120.3 1139.4 1149.0 11342.9 11357.5 11370.4 11371.8 11396.1 4621.0 4639.9 4720.5 4736.0 4736.6 9797.6 9799.2 9799.5 9806.0 9810.1 5231.2 5264.8 5270.7 5274.3 5278.0 3973.6 4488.2 4504.5 4619.6 4821.6 3915.8 3997.0 4013.4 4048.1 4065.7 1275.9 1297.1 1306.1 1312.1 1313.9 1356.9 1357.9 1394.6 1398.6 1423.9 7781.7 7825.9 7844.7 7866.7 7909.0 486.1 489.6 489.7 499.2 501.1 6059.3 6129.2 6154.4 6157.4 6220.1 9893.5 10069.7 10092.4 10165.1 10185.8 9816.0 9974.3 10011.6 10019.5 10060.5 7344.6 7400.6 7413.3 7482.1 7487.4 7443.7 7479.9 7524.3 7526.5 7530.8 8777.0 8911.2 8980.8 8988.2 9008.3 9205.3 9270.5 9295.6 9318.3 9371.3 6398.4 6546.1 7104.9 7266.2 7328.3 7967.3 7979.2 7991.9 8030.2 8032.3 7155.0 7381.0 7394.0 7467.5 7470.8 7048.2 7122.6 7147.5 7156.0 7196.2 7364.0 7456.8 7466.3 7471.0 7483.0 6693.6 6698.5 6741.7 6759.7 6798.5 6822.7 6968.9 6985.2 6986.0 6995.1 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | [#4] prototype.html Cycles:180 Average:5200.22 Median:5956.31 stddev:1555.62 (26.1%) stddev-sans-first:1516.53 17:32:40 INFO - PROCESS | 27079 | Values: 335.6 337.5 337.8 339.8 346.6 5831.2 5841.6 5848.2 5863.8 5867.8 5818.1 5821.8 5824.6 5824.7 5839.7 4298.7 4392.9 4447.9 4474.0 4480.7 4450.1 4461.0 4465.8 4477.3 4482.3 4411.9 4453.4 4475.3 4480.6 4483.9 4246.4 4398.8 4470.9 4480.5 4506.5 3960.1 3964.7 3966.6 3966.9 3973.0 5647.1 5657.6 5667.8 5668.0 5681.2 5265.7 5266.2 5271.7 5272.2 5277.3 6192.5 6198.6 6198.8 6199.3 6205.4 4183.7 4346.7 4354.1 4440.0 4441.7 6453.3 6477.5 6510.7 6530.8 6530.9 4465.1 4468.1 4472.0 4475.1 4476.4 4529.9 4531.1 4532.9 4533.4 4535.4 5212.3 5215.9 5216.0 5219.7 5227.2 6088.9 6288.1 6290.4 6292.7 6298.0 1572.7 1579.7 1588.5 1589.3 1594.8 1011.7 1063.8 1065.3 1074.9 1090.2 6008.2 6008.3 6049.1 6052.8 6059.4 6369.5 6377.9 6383.9 6391.0 6397.0 6034.3 6038.0 6041.7 6042.7 6052.8 3400.4 3424.3 3433.2 3436.2 3436.4 6484.6 6593.7 6643.8 6645.3 6652.4 6477.9 6518.6 6519.8 6534.3 6534.7 6558.6 6613.2 6615.8 6631.8 6633.6 6333.3 6335.3 6335.7 6336.0 6349.4 6118.1 6274.5 6278.4 6284.1 6340.2 6601.8 6630.1 6632.8 6635.9 6655.8 4454.2 4456.0 4458.9 4467.5 4473.3 6342.1 6350.1 6356.1 6359.3 6367.1 6207.6 6208.2 6212.7 6214.1 6218.7 6041.0 6126.6 6176.8 6179.6 6182.9 6061.8 6079.2 6085.9 6086.4 6090.8 6206.9 6210.4 6215.3 6218.3 6232.1 5904.4 6037.3 6068.9 6082.5 6083.4 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - PROCESS | 27079 | [#5] yui.html Cycles:180 Average:14674.72 Median:49769.88 stddev:17574.46 (35.3%) stddev-sans-first:17592.99 17:32:40 INFO - PROCESS | 27079 | Values: 826.1 837.3 837.7 839.6 845.2 12905.4 12969.9 12991.4 13045.6 13098.0 13099.0 13122.6 13196.3 14096.6 14218.7 826.9 830.8 839.0 839.6 842.3 829.4 830.7 831.7 832.4 833.9 870.4 871.2 871.8 871.9 872.2 866.7 867.3 868.5 870.4 871.3 638.3 639.5 639.5 640.0 640.3 13215.4 13241.1 13279.0 13394.1 13413.9 12975.4 12992.0 13016.7 13130.2 13209.0 10676.8 10807.7 10826.9 10916.6 11006.0 3834.3 3835.7 3863.3 3889.6 3943.2 46254.5 52917.0 59604.4 60222.4 60438.4 10694.9 10840.7 10903.7 10919.6 11139.0 18719.7 18781.0 18785.1 18790.4 18848.5 8518.6 8639.7 8644.0 8708.0 8836.7 4540.9 4623.3 4726.3 4732.3 4924.8 3344.5 3369.0 3369.5 3373.7 3380.8 588.1 606.3 608.7 609.2 614.2 668.4 673.9 679.3 686.2 690.4 8281.9 8312.2 8456.6 8562.4 8652.8 588.7 591.6 649.7 659.8 668.3 3951.9 4076.8 4080.2 4095.5 4125.8 63448.7 65354.7 65398.3 65470.7 65551.7 45231.3 47695.8 53410.5 54100.7 54987.7 49947.5 51337.2 51573.5 51825.0 52352.5 8604.8 8635.4 8907.3 8981.3 9073.3 35594.0 35648.5 36452.8 36519.8 36729.8 46645.3 46668.3 49592.3 50456.7 51047.5 11619.2 11731.4 11755.6 11799.3 12203.3 11953.3 12140.4 12235.0 12499.6 12643.2 10789.2 11100.1 11326.5 11564.7 11611.9 11706.7 11804.9 11815.2 11861.5 11907.5 11290.2 11373.4 11393.0 11561.9 11734.5 9323.6 9376.4 9449.2 9513.4 9588.4 9244.4 9374.3 9469.6 9481.9 9561.3 17:32:40 INFO - PROCESS | 27079 | -------- Summary: end -------- 17:32:40 INFO - PROCESS | 27079 | 17:32:40 INFO - TEST-INFO | 27079: exit 0 17:32:40 INFO - TEST-OK | dromaeo_css | took 1110187ms 17:32:40 INFO - TEST-START | kraken 17:32:40 INFO - operating with platform_type : linux_ 17:32:40 INFO - Initialising browser for kraken test... 17:32:40 INFO - TEST-INFO | started process 27265 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpndr7rE/profile http://localhost:35963/getInfo.html) 17:32:44 INFO - PROCESS | 27265 | __metrics Screen width/height:1600/1200 17:32:44 INFO - PROCESS | 27265 | colorDepth:24 17:32:44 INFO - PROCESS | 27265 | Browser inner width/height: 1024/697 17:32:44 INFO - PROCESS | 27265 | __metrics 17:32:45 ERROR - PROCESS | 27265 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:32:45 INFO - PROCESS | 27265 | 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. 17:32:46 INFO - TEST-INFO | 27265: exit 0 17:32:46 INFO - Browser initialized. 17:32:46 INFO - Running cycle 1/1 for kraken test... 17:32:46 INFO - TEST-INFO | started process 27348 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpndr7rE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:57 INFO - PROCESS | 27348 | RSS: Main: 156123136 17:32:57 INFO - PROCESS | 27348 | 17:33:00 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35963/tests/kraken/driver.html?testName=audio-beat-detection) 17:33:00 INFO - PROCESS | 27348 | RSS: Main: 197447680 17:33:00 INFO - PROCESS | 27348 | 17:33:03 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35963/tests/kraken/driver.html?testName=audio-dft) 17:33:04 INFO - PROCESS | 27348 | RSS: Main: 186818560 17:33:04 INFO - PROCESS | 27348 | 17:33:07 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35963/tests/kraken/driver.html?testName=audio-fft) 17:33:07 INFO - PROCESS | 27348 | RSS: Main: 171986944 17:33:07 INFO - PROCESS | 27348 | 17:33:09 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35963/tests/kraken/driver.html?testName=audio-oscillator) 17:33:10 INFO - PROCESS | 27348 | RSS: Main: 173993984 17:33:10 INFO - PROCESS | 27348 | 17:33:12 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35963/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:13 INFO - PROCESS | 27348 | RSS: Main: 176582656 17:33:13 INFO - PROCESS | 27348 | 17:33:16 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35963/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:16 INFO - PROCESS | 27348 | RSS: Main: 177496064 17:33:16 INFO - PROCESS | 27348 | 17:33:19 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35963/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:20 INFO - PROCESS | 27348 | RSS: Main: 176459776 17:33:20 INFO - PROCESS | 27348 | 17:33:23 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35963/tests/kraken/driver.html?testName=json-parse-financial) 17:33:23 INFO - PROCESS | 27348 | RSS: Main: 177623040 17:33:23 INFO - PROCESS | 27348 | 17:33:25 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35963/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:26 INFO - PROCESS | 27348 | RSS: Main: 187813888 17:33:26 INFO - PROCESS | 27348 | 17:33:27 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:28 INFO - PROCESS | 27348 | RSS: Main: 183009280 17:33:28 INFO - PROCESS | 27348 | 17:33:30 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:30 INFO - PROCESS | 27348 | RSS: Main: 200179712 17:33:30 INFO - PROCESS | 27348 | 17:33:33 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:33 INFO - PROCESS | 27348 | RSS: Main: 206979072 17:33:33 INFO - PROCESS | 27348 | 17:33:36 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:36 INFO - PROCESS | 27348 | RSS: Main: 206168064 17:33:36 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | Cycle 1(1): loaded http://localhost:35963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35963/tests/kraken/driver.html?testName=ai-astar) 17:33:38 INFO - PROCESS | 27348 | RSS: Main: 265367552 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | __start_tp_report 17:33:38 INFO - PROCESS | 27348 | _x_x_mozilla_page_load 17:33:38 INFO - PROCESS | 27348 | _x_x_mozilla_page_load_details 17:33:38 INFO - PROCESS | 27348 | |i|pagename|runs| 17:33:38 INFO - PROCESS | 27348 | |0;ai-astar;108;108;104;109;109;110;99;109;110;108 17:33:38 INFO - PROCESS | 27348 | |1;audio-beat-detection;150;125;151;181;132;151;158;124;184;125 17:33:38 INFO - PROCESS | 27348 | |2;audio-dft;163;164;162;160;161;160;163;164;162;163 17:33:38 INFO - PROCESS | 27348 | |3;audio-fft;72;75;101;98;71;73;76;125;92;73 17:33:38 INFO - PROCESS | 27348 | |4;audio-oscillator;92;93;144;94;93;93;147;92;92;135 17:33:38 INFO - PROCESS | 27348 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 17:33:38 INFO - PROCESS | 27348 | |6;imaging-darkroom;145;145;146;146;145;145;145;145;145;145 17:33:38 INFO - PROCESS | 27348 | |7;imaging-desaturate;100;95;95;96;95;95;96;96;95;95 17:33:38 INFO - PROCESS | 27348 | |8;json-parse-financial;58;57;56;54;55;57;55;65;53;54 17:33:38 INFO - PROCESS | 27348 | |9;json-stringify-tinderbox;59;60;60;61;60;61;60;59;60;60 17:33:38 INFO - PROCESS | 27348 | |10;stanford-crypto-aes;78;81;79;86;78;78;78;78;78;78 17:33:38 INFO - PROCESS | 27348 | |11;stanford-crypto-ccm;125;116;110;108;115;108;114;113;109;111 17:33:38 INFO - PROCESS | 27348 | |12;stanford-crypto-pbkdf2;143;145;141;142;143;144;147;134;143;141 17:33:38 INFO - PROCESS | 27348 | |13;stanford-crypto-sha256-iterative;64;63;62;63;63;61;62;63;64;63 17:33:38 INFO - PROCESS | 27348 | __end_tp_report 17:33:38 INFO - PROCESS | 27348 | __start_cc_report 17:33:38 INFO - PROCESS | 27348 | _x_x_mozilla_cycle_collect,1092 17:33:38 INFO - PROCESS | 27348 | __end_cc_report 17:33:38 INFO - PROCESS | 27348 | __startTimestamp1458693218884__endTimestamp 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | ------- Summary: start ------- 17:33:38 INFO - PROCESS | 27348 | Number of tests: 14 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.41 (3.1%) stddev-sans-first:3.61 17:33:38 INFO - PROCESS | 27348 | Values: 108.0 108.0 104.0 109.0 109.0 110.0 99.0 109.0 110.0 108.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:151.00 stddev:22.10 (14.6%) stddev-sans-first:23.43 17:33:38 INFO - PROCESS | 27348 | Values: 150.0 125.0 151.0 181.0 132.0 151.0 158.0 124.0 184.0 125.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.48 (0.9%) stddev-sans-first:1.54 17:33:38 INFO - PROCESS | 27348 | Values: 163.0 164.0 162.0 160.0 161.0 160.0 163.0 164.0 162.0 163.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#3] audio-fft Cycles:10 Average:85.60 Median:74.00 stddev:17.96 (24.3%) stddev-sans-first:18.37 17:33:38 INFO - PROCESS | 27348 | Values: 72.0 75.0 101.0 98.0 71.0 73.0 76.0 125.0 92.0 73.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:92.50 stddev:24.00 (25.9%) stddev-sans-first:24.79 17:33:38 INFO - PROCESS | 27348 | Values: 92.0 93.0 144.0 94.0 93.0 93.0 147.0 92.0 92.0 135.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:33:38 INFO - PROCESS | 27348 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:33:38 INFO - PROCESS | 27348 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:0.50 17:33:38 INFO - PROCESS | 27348 | Values: 100.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:3.41 (6.0%) stddev-sans-first:3.56 17:33:38 INFO - PROCESS | 27348 | Values: 58.0 57.0 56.0 54.0 55.0 57.0 55.0 65.0 53.0 54.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 17:33:38 INFO - PROCESS | 27348 | Values: 59.0 60.0 60.0 61.0 60.0 61.0 60.0 59.0 60.0 60.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.00 stddev:2.57 (3.3%) stddev-sans-first:2.69 17:33:38 INFO - PROCESS | 27348 | Values: 78.0 81.0 79.0 86.0 78.0 78.0 78.0 78.0 78.0 78.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#11] stanford-crypto-ccm Cycles:10 Average:112.90 Median:113.50 stddev:5.13 (4.5%) stddev-sans-first:3.05 17:33:38 INFO - PROCESS | 27348 | Values: 125.0 116.0 110.0 108.0 115.0 108.0 114.0 113.0 109.0 111.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:143.00 stddev:3.43 (2.4%) stddev-sans-first:3.63 17:33:38 INFO - PROCESS | 27348 | Values: 143.0 145.0 141.0 142.0 143.0 144.0 147.0 134.0 143.0 141.0 17:33:38 INFO - PROCESS | 27348 | 17:33:38 INFO - PROCESS | 27348 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 17:33:38 INFO - PROCESS | 27348 | Values: 64.0 63.0 62.0 63.0 63.0 61.0 62.0 63.0 64.0 63.0 17:33:38 INFO - PROCESS | 27348 | -------- Summary: end -------- 17:33:38 INFO - PROCESS | 27348 | 17:33:39 INFO - TEST-INFO | 27348: exit 0 17:33:39 INFO - TEST-OK | kraken | took 59051ms 17:33:39 INFO - SUITE-END | took 1169s 17:33:40 INFO - Completed test suite (00:19:29) 17:33:40 INFO - javascript benchmark 17:33:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3050.2221933406977, 3064.693530646934, 3103.270731378127, 3108.9378212435768, 3131.32676474558, 5139.049275883964, 5216.5565926896215, 5221.138512145496, 5244.370675518939, 5338.733063346836, 5331.893362132755, 5360.678359298445, 5367.677939323634, 5378.0857254266775, 5382.784688612461, 4748.145333839908, 4768.165571025065, 4787.353707249512, 4874.073925954075, 4883.511648835123, 4648.511906249846, 4821.90356192876, 4854.708717476963, 4892.094962431944, 4917.704937703749, 4739.573438390561, 4761.309610106532, 4782.30656554801, 4803.759812009385, 4842.394700662418, 4769.95230047702, 4771.0, 4794.113089078497, 4796.376471058775, 4831.154547954129, 4631.004334068158, 4716.151092803294, 4796.952030479685, 4815.205491093965, 4830.154722923475, 5209.531142197183, 5233.21501774733, 5236.764345604457, 5248.0553500369915, 5254.343207099113, 5705.400932902068, 5717.42825717425, 5721.199032135462, 5721.971390143064, 5729.226554415142, 5539.778408863641, 5653.717314134318, 5694.886102277973, 5707.315122185364, 5739.196512488255, 5273.578113750891, 5344.331958505187, 5346.331708536433, 5346.385165705955, 5347.679139251657, 5851.531877449879, 5870.970645146833, 5872.647641141545, 5877.206577112121, 5879.470847623649, 5462.180672899097, 5578.693171875505, 5610.0, 5610.635308704921, 5664.0, 5627.240322556402, 5628.60599758013, 5629.859253518613, 5632.774689012475, 5659.179418984224, 5456.345238571397, 5629.380768115504, 5634.295713035871, 5640.323161220597, 5651.406602306699, 5657.688827114466, 5683.886322273532, 5691.800786972436, 5693.402192769782, 5735.254416925773, 4320.524742278347, 4328.394024836525, 4329.523752387235, 4340.392345071693, 4371.388005679208, 3774.6791522720328, 3826.942595861064, 3853.1523064925673, 3899.922001559953, 3908.355121404936, 5407.621466497308, 5438.401775804658, 5441.59188060897, 5451.0, 5480.095784195642, 5694.4590263924865, 5700.23046888673, 5701.486866182064, 5704.800331988444, 5705.5720820938595, 5235.790568377299, 5414.83755487336, 5425.7829686812875, 5484.698341591171, 5503.3395992481155, 4935.136351138608, 4940.802367905316, 4959.2809042688605, 4959.727215003138, 4973.55238028572, 5984.640921544721, 5998.340182579913, 6002.939970600325, 6003.729832157564, 6058.212432383762, 5599.888002239851, 5693.28833895763, 5758.539316854558, 5768.451997060272, 5792.884142317214, 5951.851203719942, 5958.582899197015, 5962.970185149046, 5971.790987315423, 5976.282846058501, 5613.550915926798, 5614.90509350689, 5617.269754931833, 5618.044932361427, 5619.747111379916, 5575.275214222125, 5612.7754889803955, 5645.068563686946, 5657.915131272952, 5704.030314846569, 5568.749406276646, 5582.051051321204, 5591.748371323219, 5599.384067752462, 5601.187827765033, 5401.837944861661, 5493.025205052863, 5542.667439953616, 5545.805896793593, 5556.16657501378, 5467.917981230205, 5493.313335833021, 5517.144842549411, 5520.834374968757, 5560.02699527573, 5579.804706835242, 5588.133839254922, 5614.466625670555, 5618.073017951992, 5635.549156067423, 5336.199570064521, 5479.753411096431, 5480.451954804487, 5511.338639363302, 5567.916481252865], "unit": "score", "name": "dojo.html", "value": 5241.456491540726}, {"lowerIsBetter": false, "replicates": [548.5035901626256, 556.9526590239827, 571.1689491789447, 574.0757380617206, 591.3701907468547, 27337.863310683442, 27576.310592235204, 27754.30614234645, 27799.305017374576, 37790.43314350287, 40334.59665403345, 40668.59331406685, 40679.796601016955, 40914.386284205764, 40985.79507102468, 8565.571721413935, 8743.038265790758, 8750.649974001064, 8754.649814007464, 8758.56207189638, 8578.44240124393, 8588.227059564639, 8704.04255531891, 8707.825843483126, 8710.956445217766, 8670.176333248332, 8785.0, 8796.252318552899, 8796.824063518727, 9065.95467022664, 8887.68893088742, 8963.820723585492, 8969.461832290084, 8970.730878073635, 8971.910280897206, 8799.0, 8900.643974241022, 8938.1508756668, 8954.059823718546, 8955.955220223923, 40006.59993400058, 40400.59599403998, 40479.7976010121, 40494.1901161978, 40503.18993620141, 3505.2814173094453, 3594.0475773919934, 3826.617338266151, 3897.883063508071, 4383.64930805538, 30228.395432091456, 30416.087517374515, 30483.0, 30544.236394090105, 30984.225394365098, 4352.455943007124, 4398.73607583546, 4408.713433626836, 4575.107853968478, 4598.678092533524, 328561.0, 329896.0, 332109.0, 332181.0, 333151.0, 57609.0, 58832.41167588355, 59014.40985590175, 59036.0, 59060.0, 61049.38950610526, 61327.38672613306, 61364.0, 61385.77228455495, 61695.6915215421, 16858.747118793228, 17082.743758843626, 17086.0, 17092.91453542749, 17095.401660941807, 13193.40629671667, 13241.3379331035, 13255.204687718768, 13269.402876870565, 13271.800922986164, 17074.48776536706, 18819.341323053628, 18845.340413085476, 18910.0, 18993.715094273597, 7232.349088581947, 7474.813129671802, 7532.849343013109, 7557.508761930457, 7583.0, 1065.7548763784218, 1110.1826429509313, 1114.3146964616865, 1132.7904337697553, 1159.3739380734478, 30504.38991220163, 30849.845750771103, 31189.22026949299, 31380.843095784832, 31810.522842157385, 1134.8978591926766, 1153.0084127650214, 1184.1231647838101, 1195.7190060335813, 1242.9005679545614, 15758.212089395485, 15930.840691593168, 16056.919715401582, 16108.27512761905, 16351.672966540602, 394849.0, 397116.0, 400570.0, 400983.0, 401211.0, 55387.0, 55522.44477555253, 55630.72184639051, 55695.0, 55713.0, 1196.8503937007874, 1416.185693226399, 1427.4290283886528, 1430.7138572285585, 1431.3773508523825, 25504.2348729531, 26203.0, 26950.59574106351, 27134.592981104903, 27876.0, 42747.0, 42862.57137428711, 43241.0, 43356.566434335255, 43378.13243735045, 248651.0, 254193.0, 255221.0, 255333.0, 255636.0, 29066.0, 34452.31095378028, 35041.29917401689, 35454.25105248694, 35996.64003359933, 44708.0, 44734.77632611816, 45052.774736126106, 45206.32190517079, 45311.773441133904, 36914.26171476609, 37096.44355334618, 37167.0, 37786.24427511379, 38269.4259586112, 36580.45129323009, 37252.25495490129, 38159.0, 38281.23437531178, 38689.0, 38690.0, 38843.417348739225, 39270.214595708494, 39406.0, 39508.0, 32057.198570035936, 33594.49608255829, 33883.36864301466, 34073.0, 34306.65693343035, 26636.7336326642, 26847.86576067185, 26973.595396069468, 26978.595321070592, 27035.459290814466], "unit": "score", "name": "ext.html", "value": 19098.478848275678}, {"lowerIsBetter": false, "replicates": [377.3057574063722, 380.3306181121226, 381.8033712637991, 385.35645472061657, 386.49176333121943, 17120.999999999985, 18160.727589086157, 18225.81774182258, 18522.44432667019, 18550.907245463786, 16965.3213871445, 17703.0, 18088.909555452203, 18105.0, 18120.909395453004, 5316.38861530925, 5460.918086228709, 5481.671099734029, 5485.177223416479, 5488.286522752037, 3918.725689201757, 5421.186821976696, 5851.297844258695, 6085.543584231178, 6088.908666370008, 6028.21633187685, 6035.366286539916, 6054.455099041085, 6070.0, 6071.1803906472505, 5759.4528519790765, 5908.822735317947, 5915.201447804534, 5935.139404786303, 5973.342932277446, 3494.2312691207894, 5061.746912654353, 5229.947700523022, 5231.607629427808, 5232.189010703347, 20241.291554795513, 20289.28987485431, 20380.184792608277, 22063.66904496434, 22085.668714969288, 2329.650552417134, 2547.630593563923, 2562.8077894157827, 2727.9454410911867, 3060.1737530866762, 9812.264080194014, 9881.0, 9951.353162044445, 10130.189584833195, 13714.725705485835, 1896.5543097372106, 1968.173367185771, 2002.149086638173, 2014.6575082236054, 2035.9287424940205, 61059.389406105816, 63174.0523892142, 63323.366766332205, 68558.0, 71651.04361954756, 10839.241253112206, 10852.837207441895, 11051.336919784839, 11066.114710823114, 11115.44422778874, 14312.212828294336, 14332.641683957985, 14416.495422660157, 14427.49503767363, 14429.20639364845, 8228.547429891414, 8472.068072512018, 8479.618417171243, 8587.441816281922, 8587.656493740305, 8351.20663536963, 8395.916040839636, 8400.033996090406, 8452.450590711584, 8531.274841638406, 4686.039361930864, 4698.694584851974, 4704.976475117603, 4762.14281429346, 4811.27830825379, 1783.5273652482103, 1867.7011678131435, 3151.2909595341325, 3169.4770362890326, 3191.3617276544783, 907.7186072317471, 1030.8299130643509, 1033.121846430543, 1063.7659714862718, 1081.9513121909533, 17844.643107137785, 18103.366382176562, 18186.45440636783, 18576.349827756236, 18737.25050997972, 981.6711401680517, 1012.1851909213154, 1021.22897212604, 1039.9064084232455, 1051.9263651544472, 10275.486225688686, 10396.48017599117, 10403.947980260202, 10404.219683523766, 10569.682909512727, 485628.0, 486063.0, 486362.0, 495336.5233173811, 503160.0, 78642.6067869657, 80843.0, 83293.58353208317, 83314.58342708247, 83627.0, 1014.7108074198966, 1034.2656713733184, 1053.6048981631889, 1061.6337363609696, 1062.0812996757904, 16227.675446491241, 16318.918405407898, 16345.67308653844, 16420.67158656796, 16450.0, 36387.0, 36962.0, 37785.0, 38422.399428706696, 39149.0, 54283.18575221454, 54359.0, 54442.18336725031, 54525.0, 54685.0, 8302.626381812712, 8364.205400486944, 8377.078521362768, 8395.874061888955, 8419.915800841913, 12291.385430728249, 12513.374331283581, 12557.121001529806, 12577.308248046445, 12586.24482531051, 10433.426161560883, 10689.572417103229, 10834.891651083388, 10860.239783215098, 11085.0, 10884.51019704131, 11003.064739497233, 11065.170112241774, 11187.440627968406, 11244.381559014333, 11036.613718519813, 11139.498722557666, 11287.887121129012, 11381.203315768147, 11407.144464165054, 8060.83878322442, 8126.634301456331, 8215.342772578299, 8267.255946964802, 11201.551937922392, 10913.890861091288, 10948.178886583379, 10997.835032474359, 11263.605773797877, 11408.372539510407], "unit": "score", "name": "jquery.html", "value": 9043.636979607982}, {"lowerIsBetter": false, "replicates": [1323.3383308345826, 1533.47095252138, 1550.2403822127153, 1729.9221535030922, 1848.2237460266688, 7812.0, 7987.5207487550715, 8008.759737207886, 8011.799705007378, 8015.7194498192575, 7867.606619669023, 8029.156938521459, 8035.6785728570785, 8040.437169398145, 8043.396745244116, 1964.2241314680693, 2010.035183112107, 2335.6730057791924, 2340.801031912281, 2367.5856725073045, 2384.213209640823, 2396.436837343223, 2396.4488167721433, 2396.6285225789943, 2396.9760302397012, 2303.8387312888103, 2308.607536718762, 2313.6992191015142, 2365.95268094638, 2366.763323667628, 2323.8605683659034, 2341.6487526870937, 2354.0701422937927, 2354.2701762453694, 2389.438481956739, 2349.1777877742825, 2356.5051339218785, 2389.319044072431, 2391.1272385579314, 2398.6881705378364, 7895.171007044235, 7903.446758726892, 7937.603119843985, 7949.7217597383815, 7962.0, 5119.385673719177, 5236.293100431431, 5241.8165364212455, 5242.97378513105, 5244.213367994793, 3302.3230237801195, 3353.3460975109865, 3394.6096198937194, 3429.331280400323, 3447.7414193935556, 1104.6851647280487, 1113.8162203236457, 1120.3445984099312, 1139.4132022008673, 1149.0233301693577, 11342.943285283603, 11357.545698172064, 11370.374629395379, 11371.829422558669, 11396.145289103268, 4621.0, 4639.884002899955, 4720.527947205252, 4735.95264047362, 4736.621070314367, 9797.608095676236, 9799.216062714966, 9799.461029643295, 9805.950970245103, 9810.117089461983, 5231.241469986907, 5264.815731449381, 5270.657407268592, 5274.26160337553, 5277.973610131925, 3973.5827738087664, 4488.192125417456, 4504.504504504502, 4619.561141691601, 4821.63837712173, 3915.8237879295502, 3997.040710229582, 4013.3578627419474, 4048.0891799344913, 4065.7357271777832, 1275.8660340664283, 1297.1049975516862, 1306.072688391234, 1312.061875758818, 1313.9277339746216, 1356.9118007329491, 1357.9049466537444, 1394.623451668044, 1398.5874167120724, 1423.8789702875372, 7781.727639532589, 7825.882611760828, 7844.686212551548, 7866.72466463671, 7909.0, 486.0837321648718, 489.6034212288058, 489.73799017525454, 499.1564256406661, 501.09552258174347, 6059.272887253558, 6129.172561704202, 6154.415330543591, 6157.445829875243, 6220.066989951543, 9893.45585992763, 10069.748256293651, 10092.444915529717, 10165.13596344319, 10185.847212291821, 9816.0, 9974.320586164878, 10011.649592264235, 10019.549120289605, 10060.547275372626, 7344.559326440431, 7400.555966642019, 7413.258674132544, 7482.102147742197, 7487.438442116863, 7443.739469118555, 7479.925200748141, 7524.322810947041, 7526.5107767994905, 7530.774076777706, 8777.03452620224, 8911.2425443838, 8980.775480613036, 8988.235999940078, 9008.32437567172, 9205.30960177976, 9270.53647317645, 9295.581698823435, 9318.347715659838, 9371.250299975849, 6398.424141827071, 6546.149000629887, 7104.928950710633, 7266.200717920919, 7328.267173282629, 7967.32277756374, 7979.16218797018, 7991.920080799117, 8030.156833532628, 8032.317253033558, 7155.0, 7381.04046473955, 7393.963030184815, 7467.477276590586, 7470.775876723707, 7048.224695283618, 7122.643867806485, 7147.493867842761, 7156.0, 7196.244394338519, 7364.0426744522865, 7456.813579660552, 7466.25337466249, 7471.0, 7483.027206463125, 6693.631850248088, 6698.531102822755, 6741.662916854039, 6759.729610815512, 6798.456123510206, 6822.727090916308, 6968.930310697031, 6985.1617805863625, 6985.965070174617, 6995.055667484824], "unit": "score", "name": "mootools.html", "value": 4655.135264284785}, {"lowerIsBetter": false, "replicates": [335.59895924370386, 337.50218427818953, 337.822643112366, 339.79272643687347, 346.57890662844625, 5831.212786273852, 5841.649501029936, 5848.210491583635, 5863.824085277443, 5867.794627188049, 5818.1272809078655, 5821.767129314822, 5824.592278540504, 5824.679642619654, 5839.678817665027, 4298.7205831621, 4392.890177745566, 4447.888802779924, 4473.99335149592, 4480.731156130626, 4450.109978004412, 4460.955390446086, 4465.799039043251, 4477.283634618461, 4482.282834746441, 4411.911761764763, 4453.354263631772, 4475.328700694889, 4480.551944805526, 4483.887902802439, 4246.405503229535, 4398.780060996969, 4470.9105817883465, 4480.48474425442, 4506.526814684476, 3960.089179488734, 3964.7224694271413, 3966.6430021297933, 3966.8809935701975, 3972.980135099306, 5647.0964645656495, 5657.6322539035245, 5667.829965101054, 5668.0, 5681.204631351614, 5265.6840589564745, 5266.183741520071, 5271.710055946922, 5272.156454967225, 5277.261183434322, 6192.535559832985, 6198.566100372976, 6198.752049917998, 6199.349068347804, 6205.410486003822, 4183.707140500166, 4346.717463364903, 4354.129174165148, 4440.045390241082, 4441.71128876622, 6453.257875344301, 6477.48180145592, 6510.674466276667, 6530.804075877779, 6530.93469065308, 4465.106978604292, 4468.061707041557, 4472.0, 4475.149721552894, 4476.395686582335, 4529.886752831206, 4531.116432295671, 4532.9093418132115, 4533.410656614619, 4535.387722657399, 5212.270282160501, 5215.947840521546, 5215.973920130375, 5219.660722053054, 5227.18978558324, 6088.939110608926, 6288.056791481315, 6290.370962903673, 6292.685365731695, 6297.992321228581, 1572.6540161164526, 1579.676166385888, 1588.5313832419463, 1589.2927647196886, 1594.8484893935058, 1011.7369483934231, 1063.7925604507047, 1065.2649671726483, 1074.8763892152504, 1090.2095980414135, 6008.188894499274, 6008.279006519158, 6049.122877182784, 6052.788152414644, 6059.394060593993, 6369.522285828489, 6377.8519866424485, 6383.904241436382, 6391.0, 6397.0, 6034.306054803666, 6037.969810150921, 6041.72812223451, 6042.6978651067275, 6052.818415447544, 3400.3879301725433, 3424.280901010766, 3433.1931995980926, 3436.244026314207, 3436.381451338783, 6484.643344616092, 6593.703283352164, 6643.800685979331, 6645.302243264484, 6652.401283884474, 6477.935220647827, 6518.641474718936, 6519.771807986793, 6534.281229064799, 6534.673266336664, 6558.573692710054, 6613.173353330833, 6615.76844810439, 6631.767888123893, 6633.6019838809825, 6333.2716737575765, 6335.334789847, 6335.714892829741, 6336.0, 6349.396807303298, 6118.112873633388, 6274.46667033289, 6278.434940855345, 6284.120223168851, 6340.175777149126, 6601.834954125993, 6630.104935833793, 6632.834179145367, 6635.900461493178, 6655.767048153291, 4454.175977444183, 4456.041950980555, 4458.933116003327, 4467.486239082417, 4473.2842745160615, 6342.080398342122, 6350.079238510298, 6356.078368636429, 6359.268684101387, 6367.076773867856, 6207.596506227081, 6208.192934918432, 6212.720427580679, 6214.130021796862, 6218.657973811484, 6041.029517885962, 6126.632402055891, 6176.7838125665385, 6179.567430279837, 6182.876342473035, 6061.7575296987625, 6079.1793107931635, 6085.878282434415, 6086.391360863879, 6090.786822461193, 6206.937930620636, 6210.4100110489435, 6215.316315205414, 6218.347073557211, 6232.096346029891, 5904.439078287556, 6037.305709843425, 6068.9089663654195, 6082.513398928164, 6083.361247069171], "unit": "score", "name": "prototype.html", "value": 4697.369277601072}, {"lowerIsBetter": false, "replicates": [826.06241915426, 837.2924878477684, 837.6942416018154, 839.6347588798877, 845.2097289034753, 12905.419256133473, 12969.935150324236, 12991.350432478386, 13045.608631741039, 13098.0, 13099.0, 13122.606321810337, 13196.34018299086, 14096.64758381041, 14218.71562568748, 826.8635675113599, 830.8379865926147, 838.9832203355929, 839.559231403515, 842.3345557009955, 829.4235506323078, 830.7383174300077, 831.7296878514477, 832.3507664022043, 833.9332853371747, 870.4037734152095, 871.1593312453481, 871.8125602995354, 871.9346049046316, 872.2193636695185, 866.7226487523994, 867.301822033263, 868.5179725252482, 870.3907264914553, 871.3247233394106, 638.3425072175667, 639.5299454900644, 639.5331408072087, 639.9680015999181, 640.2956747577674, 13215.405306761219, 13241.073124881263, 13279.0, 13394.129381590263, 13413.932930335286, 12975.416106275241, 12992.0, 13016.739665206644, 13130.212187268698, 13209.0, 10676.839847402296, 10807.729806754895, 10826.945865270623, 10916.617918372898, 11006.0, 3834.3098242316373, 3835.7314987950854, 3863.304605171068, 3889.572147063821, 3943.2310699413624, 46254.53745462536, 52917.0, 59604.40395596032, 60222.39777602212, 60438.39561604416, 10694.94652526748, 10840.728981775519, 10903.727406814734, 10919.563217471372, 11139.0, 18719.719204211946, 18781.0, 18785.06074696287, 18790.436286911416, 18848.52878678044, 8518.616662250213, 8639.740807775777, 8644.0, 8707.956460217658, 8836.734897952943, 4540.931886021713, 4623.302201833976, 4726.291056341576, 4732.313814496879, 4924.75376231187, 3344.5317655528247, 3368.9663103369144, 3369.4777309517062, 3373.730101591867, 3380.7802492837886, 588.0825911577953, 606.3239487970969, 608.7473698415197, 609.2110716621985, 614.1984709953554, 668.4318329419954, 673.8787018336649, 679.341039191983, 686.2382755141789, 690.4303949241895, 8281.917180828115, 8312.21034001769, 8456.577171141418, 8562.357823163287, 8652.760147527666, 588.6850534963773, 591.5947575910515, 649.746598826458, 659.7822718502882, 668.3350066683681, 3951.913223863403, 4076.8165432555606, 4080.2043601498017, 4095.4675892133832, 4125.834966601303, 63448.68275658592, 65354.67322663356, 65398.346016539224, 65470.67264663742, 65551.67224163849, 45231.321530177076, 47695.761521192864, 53410.46589534055, 54100.729496352265, 54987.72506137444, 49947.50052499501, 51337.229941550904, 51573.48426515762, 51825.0, 52352.47647523552, 8604.82790344177, 8635.395522313378, 8907.331950103899, 8981.326400519856, 9073.319501037317, 35594.0, 35648.4652730204, 36452.81773591115, 36519.81740091283, 36729.816350918074, 46645.30032049454, 46668.299975501075, 49592.256116159006, 50456.74771626118, 51047.48952510576, 11619.244749091282, 11731.41342932867, 11755.588554400554, 11799.292042477478, 12203.328816915155, 11953.282803031845, 12140.392980351124, 12235.0, 12499.625011249676, 12643.241405515699, 10789.184043787582, 11100.11199104086, 11326.490307936327, 11564.710882228012, 11611.88388116108, 11706.70733231676, 11804.881951180721, 11815.17293789461, 11861.525538978689, 11907.464164112462, 11290.15323850698, 11373.374464404536, 11393.0, 11561.88438115608, 11734.530618775154, 9323.627054917728, 9376.3905346155, 9449.196818270524, 9513.381630194015, 9588.37675551087, 9244.352895297265, 9374.25005999532, 9469.621215151317, 9481.857772133562, 9561.282903782105], "unit": "score", "name": "yui.html", "value": 6570.882341176807}], "name": "dromaeo_css", "value": 7118.262417222232}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 108.0, 104.0, 109.0, 109.0, 110.0, 99.0, 109.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 151.0, 181.0, 132.0, 151.0, 158.0, 124.0, 184.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 160.0, 161.0, 160.0, 163.0, 164.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 101.0, 98.0, 71.0, 73.0, 76.0, 125.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 144.0, 94.0, 93.0, 93.0, 147.0, 92.0, 92.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [100.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 56.0, 54.0, 55.0, 57.0, 55.0, 65.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 59.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.0}, {"lowerIsBetter": true, "replicates": [78.0, 81.0, 79.0, 86.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [125.0, 116.0, 110.0, 108.0, 115.0, 108.0, 114.0, 113.0, 109.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.9}, {"lowerIsBetter": true, "replicates": [143.0, 145.0, 141.0, 142.0, 143.0, 144.0, 147.0, 134.0, 143.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 62.0, 63.0, 63.0, 61.0, 62.0, 63.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.8}], "name": "kraken", "value": 1482.1000000000001}]} 17:33:40 INFO - Return code: 0 17:33:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:33:40 ERROR - # TBPL SUCCESS # 17:33:40 INFO - Running post-action listener: _resource_record_post_action 17:33:40 INFO - Running post-run listener: _resource_record_post_run 17:33:41 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275681280; Read time: 176; Write time: 213700 17:33:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1138688; Read time: 0; Write time: 72 17:33:41 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274542592; Read time: 176; Write time: 213628 17:33:41 INFO - Running post-run listener: _upload_blobber_files 17:33:41 INFO - Blob upload gear active. 17:33:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:33:41 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 17:33:41 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'] 17:33:41 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 17:33:41 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:42 INFO - (blobuploader) - INFO - Done attempting. 17:33:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:43 INFO - (blobuploader) - INFO - Done attempting. 17:33:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:43 INFO - Return code: 0 17:33:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:33:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ce7318322c76ae7e523887f8bc45500551b2ffbe1678d27d40322fe66d85dec4f00b92f903c426b948235a51976ec04b9ecfa5c35ce01fc1e77e338eaa97540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6ce79d45b45457fc2cf76f21e36e2d633c8d8d7bc8816835120b07e671b03bf84214c41bd9c8007a8d5dfcc1ccb2ea7ac1b11f4a78c6e0ad7b09e69bac2ab13"} 17:33:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:33:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:33:43 INFO - Contents: 17:33:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ce7318322c76ae7e523887f8bc45500551b2ffbe1678d27d40322fe66d85dec4f00b92f903c426b948235a51976ec04b9ecfa5c35ce01fc1e77e338eaa97540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6ce79d45b45457fc2cf76f21e36e2d633c8d8d7bc8816835120b07e671b03bf84214c41bd9c8007a8d5dfcc1ccb2ea7ac1b11f4a78c6e0ad7b09e69bac2ab13"} 17:33:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:43 INFO - Copying logs to upload dir... 17:33:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:33:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1358.193180 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 38 secs) (at 2016-03-22 17:33:42.812335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 17:33:42.815618) ========= 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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 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/9ce7318322c76ae7e523887f8bc45500551b2ffbe1678d27d40322fe66d85dec4f00b92f903c426b948235a51976ec04b9ecfa5c35ce01fc1e77e338eaa97540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6ce79d45b45457fc2cf76f21e36e2d633c8d8d7bc8816835120b07e671b03bf84214c41bd9c8007a8d5dfcc1ccb2ea7ac1b11f4a78c6e0ad7b09e69bac2ab13"} build_url:https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/SIYgXPE_SPOioVPCcykNxQ/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/9ce7318322c76ae7e523887f8bc45500551b2ffbe1678d27d40322fe66d85dec4f00b92f903c426b948235a51976ec04b9ecfa5c35ce01fc1e77e338eaa97540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6ce79d45b45457fc2cf76f21e36e2d633c8d8d7bc8816835120b07e671b03bf84214c41bd9c8007a8d5dfcc1ccb2ea7ac1b11f4a78c6e0ad7b09e69bac2ab13"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 17:33:42.840383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:33:42.840774) ========= 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=0274524eba3bdaad075c2247000001d4-1458690174.938606-1329036098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 17:33:42.925030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 17:33:42.925347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 17:33:42.925656) ========= ========= Total master_lag: 1.31 =========