builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1457537522.84 results: success (0) buildid: 20160309043048 builduid: 0127b56c37ab4ff9a64ba296d9c810af revision: 5143234fc6be8c842fa6ac7df75260fa7d43cfaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:02.847248) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:02.847805) ========= ========= Started set props: basedir (results: 0, elapsed: 6 secs) (at 2016-03-09 07:32:02.848137) ========= 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006329 basedir: '/builds/slave/test-pgo' ========= master_lag: 6.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 6 secs) (at 2016-03-09 07:32:08.899425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-03-09 07:32:08.902685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-03-09 07:32:13.925509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:13.925876) ========= 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.140511) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.146848) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.147209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.147487) ========= 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 07:32:14-- 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% 21.4M=0.001s 2016-03-09 07:32:14 (21.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092439 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.280699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.281088) ========= 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015840 ========= master_lag: 0.34 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.638098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:14.638455) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5143234fc6be8c842fa6ac7df75260fa7d43cfaa --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/mozilla-inbound --rev 5143234fc6be8c842fa6ac7df75260fa7d43cfaa --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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 07:32:15,327 truncating revision to first 12 chars 2016-03-09 07:32:15,327 Setting DEBUG logging. 2016-03-09 07:32:15,327 attempt 1/10 2016-03-09 07:32:15,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5143234fc6be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 07:32:15,613 unpacking tar archive at: mozilla-inbound-5143234fc6be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:15.240944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:15.241329) ========= echo 5143234fc6be8c842fa6ac7df75260fa7d43cfaa in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5143234fc6be8c842fa6ac7df75260fa7d43cfaa'] 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5143234fc6be8c842fa6ac7df75260fa7d43cfaa program finished with exit code 0 elapsedTime=0.004642 script_repo_revision: '5143234fc6be8c842fa6ac7df75260fa7d43cfaa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:15.300273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:15.300619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 07:32:15.313030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-09 07:32:15.313344) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:32:16 INFO - MultiFileLogger online at 20160309 07:32:16 in /builds/slave/test-pgo 07:32:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:32:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:32:16 INFO - {'append_to_log': False, 07:32:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:32:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:32:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:32:16 INFO - 'branch': 'Mozilla-Inbound', 07:32:16 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:16 INFO - 'config_files': ('talos/linux_config.py',), 07:32:16 INFO - 'default_actions': ('clobber', 07:32:16 INFO - 'read-buildbot-config', 07:32:16 INFO - 'download-and-extract', 07:32:16 INFO - 'populate-webroot', 07:32:16 INFO - 'create-virtualenv', 07:32:16 INFO - 'install', 07:32:16 INFO - 'run-tests'), 07:32:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:16 INFO - 'download_minidump_stackwalk': True, 07:32:16 INFO - 'download_symbols': 'ondemand', 07:32:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:16 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:16 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:16 INFO - 'installer_path': 'installer.exe', 07:32:16 INFO - 'log_level': 'info', 07:32:16 INFO - 'log_name': 'talos', 07:32:16 INFO - 'log_to_console': True, 07:32:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:32:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:32:16 INFO - 'opt_config_files': (), 07:32:16 INFO - 'pip_index': False, 07:32:16 INFO - 'sps_profile': False, 07:32:16 INFO - 'sps_profile_interval': 0, 07:32:16 INFO - 'suite': 'dromaeojs-e10s', 07:32:16 INFO - 'system_bits': '32', 07:32:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:16 INFO - 'title': 'talos-linux64-ix-065', 07:32:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:16 INFO - 'use_talos_json': True, 07:32:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:32:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:16 INFO - 'work_dir': 'build'} 07:32:16 INFO - ##### 07:32:16 INFO - ##### Running clobber step. 07:32:16 INFO - ##### 07:32:16 INFO - Running pre-action listener: _resource_record_pre_action 07:32:16 INFO - Running main action method: clobber 07:32:16 INFO - rmtree: /builds/slave/test-pgo/build 07:32:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:32:16 INFO - Running post-action listener: _resource_record_post_action 07:32:16 INFO - ##### 07:32:16 INFO - ##### Running read-buildbot-config step. 07:32:16 INFO - ##### 07:32:16 INFO - Running pre-action listener: _resource_record_pre_action 07:32:16 INFO - Running main action method: read_buildbot_config 07:32:16 INFO - Using buildbot properties: 07:32:16 INFO - { 07:32:16 INFO - "project": "", 07:32:16 INFO - "product": "firefox", 07:32:16 INFO - "script_repo_revision": "production", 07:32:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:32:16 INFO - "repository": "", 07:32:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:32:16 INFO - "buildid": "20160309043048", 07:32:16 INFO - "pgo_build": "True", 07:32:16 INFO - "basedir": "/builds/slave/test-pgo", 07:32:16 INFO - "buildnumber": 760, 07:32:16 INFO - "slavename": "talos-linux64-ix-065", 07:32:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:32:16 INFO - "platform": "ubuntu64_hw", 07:32:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:32:16 INFO - "branch": "mozilla-inbound", 07:32:16 INFO - "repo_path": "integration/mozilla-inbound", 07:32:16 INFO - "revision": "5143234fc6be8c842fa6ac7df75260fa7d43cfaa", 07:32:16 INFO - "stage_platform": "linux64-pgo", 07:32:16 INFO - "builduid": "0127b56c37ab4ff9a64ba296d9c810af", 07:32:16 INFO - "slavebuilddir": "test" 07:32:16 INFO - } 07:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:32:16 INFO - Running post-action listener: _resource_record_post_action 07:32:16 INFO - ##### 07:32:16 INFO - ##### Running download-and-extract step. 07:32:16 INFO - ##### 07:32:16 INFO - Running pre-action listener: _resource_record_pre_action 07:32:16 INFO - Running main action method: download_and_extract 07:32:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:32: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')]} 07:32:16 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:17 INFO - Downloaded 1361 bytes. 07:32:17 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:32:17 INFO - Using the following test package requirements: 07:32:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:32:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:32:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:32:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'jsshell-linux-x86_64.zip'], 07:32:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:32:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:32:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:32:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:32:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:32:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:32:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:17 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:18 INFO - Downloaded 23405658 bytes. 07:32:18 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'] 07:32:18 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 07:32:19 INFO - Return code: 0 07:32:19 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 07:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:19 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:20 INFO - Downloaded 23405658 bytes. 07:32:20 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'] 07:32:20 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 07:32:21 INFO - Return code: 0 07:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:21 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:22 INFO - Downloaded 10845161 bytes. 07:32:22 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'] 07:32:22 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 07:32:22 INFO - Return code: 0 07:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:22 INFO - https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/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 07:32:24 INFO - Downloaded 56211797 bytes. 07:32:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:24 INFO - mkdir: /builds/slave/test-pgo/properties 07:32:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:32:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:32:24 INFO - Contents: 07:32:24 INFO - build_url:https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:24 INFO - Running post-action listener: _resource_record_post_action 07:32:24 INFO - Running post-action listener: set_extra_try_arguments 07:32:24 INFO - ##### 07:32:24 INFO - ##### Running populate-webroot step. 07:32:24 INFO - ##### 07:32:24 INFO - Running pre-action listener: _resource_record_pre_action 07:32:24 INFO - Running main action method: populate_webroot 07:32:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:24 INFO - '--tppagecycles', 07:32:24 INFO - '7'], 07:32:24 INFO - 'tests': ['tsvgm']}}, 07:32:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:32:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:32:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'tests': ['damp', 'tps']}, 07:32:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['damp', 'tps']}, 07:32:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:32:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:24 INFO - 'other': {'tests': ['a11yr', 07:32:24 INFO - 'ts_paint', 07:32:24 INFO - 'tpaint', 07:32:24 INFO - 'sessionrestore', 07:32:24 INFO - 'sessionrestore_no_auto_restore', 07:32:24 INFO - 'tabpaint']}, 07:32:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['a11yr', 07:32:24 INFO - 'ts_paint', 07:32:24 INFO - 'tpaint', 07:32:24 INFO - 'sessionrestore', 07:32:24 INFO - 'sessionrestore_no_auto_restore', 07:32:24 INFO - 'tabpaint']}, 07:32:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['a11yr', 07:32:24 INFO - 'ts_paint', 07:32:24 INFO - 'tpaint', 07:32:24 INFO - 'sessionrestore', 07:32:24 INFO - 'sessionrestore_no_auto_restore', 07:32:24 INFO - 'tabpaint']}, 07:32:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['a11yr', 07:32:24 INFO - 'ts_paint', 07:32:24 INFO - 'tpaint', 07:32:24 INFO - 'sessionrestore', 07:32:24 INFO - 'sessionrestore_no_auto_restore', 07:32:24 INFO - 'tabpaint']}, 07:32:24 INFO - 'other_l64': {'tests': ['a11yr', 07:32:24 INFO - 'ts_paint', 07:32:24 INFO - 'tpaint', 07:32:24 INFO - 'sessionrestore', 07:32:24 INFO - 'sessionrestore_no_auto_restore', 07:32:24 INFO - 'tabpaint']}, 07:32:24 INFO - 'other_nol64': {'tests': ['a11yr', 07:32:24 INFO - 'ts_paint', 07:32:24 INFO - 'tpaint', 07:32:24 INFO - 'sessionrestore', 07:32:24 INFO - 'sessionrestore_no_auto_restore', 07:32:24 INFO - 'tabpaint']}, 07:32:24 INFO - 'svgr': {'tests': ['tsvgx', 07:32:24 INFO - 'tsvgr_opacity', 07:32:24 INFO - 'tart', 07:32:24 INFO - 'tscrollx', 07:32:24 INFO - 'cart']}, 07:32:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['tsvgx', 07:32:24 INFO - 'tsvgr_opacity', 07:32:24 INFO - 'tart', 07:32:24 INFO - 'tscrollx', 07:32:24 INFO - 'cart']}, 07:32:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'tests': ['tp5o']}, 07:32:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'talos_options': ['--e10s'], 07:32:24 INFO - 'tests': ['tp5o']}, 07:32:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'talos_options': ['--xperf_path', 07:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:24 INFO - 'tests': ['tp5n']}, 07:32:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:24 INFO - 'talos_options': ['--e10s', 07:32:24 INFO - '--xperf_path', 07:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:24 INFO - 'tests': ['tp5n']}}, 07:32:24 INFO - 'talos.zip': {'path': '', 07:32:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:24 INFO - Running post-action listener: _resource_record_post_action 07:32:24 INFO - ##### 07:32:24 INFO - ##### Running create-virtualenv step. 07:32:24 INFO - ##### 07:32:24 INFO - Running pre-action listener: _resource_record_pre_action 07:32:24 INFO - Running main action method: create_virtualenv 07:32:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:32:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:32:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:32:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:25 INFO - Using real prefix '/usr' 07:32:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:32:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:27 INFO - Installing pip.................done. 07:32:27 INFO - Return code: 0 07:32:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:32:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:32:27 INFO - Using env: {'DISPLAY': ':0', 07:32:27 INFO - 'HOME': '/home/cltbld', 07:32:27 INFO - 'LANG': 'en_US.UTF-8', 07:32:27 INFO - 'LANGUAGE': 'en_US:en', 07:32:27 INFO - 'LOGNAME': 'cltbld', 07:32:27 INFO - 'MAIL': '/var/mail/cltbld', 07:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:27 INFO - 'MOZ_NO_REMOTE': '1', 07:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:27 INFO - 'NO_EM_RESTART': '1', 07:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:27 INFO - 'SHELL': '/bin/bash', 07:32:27 INFO - 'SHLVL': '1', 07:32:27 INFO - 'TERM': 'linux', 07:32:27 INFO - 'TMOUT': '86400', 07:32:27 INFO - 'USER': 'cltbld', 07:32:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:27 INFO - '_': '/tools/buildbot/bin/python'} 07:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:32:27 INFO - Cleaning up... 07:32:27 INFO - Return code: 0 07:32:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:32:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:32:27 INFO - Using env: {'DISPLAY': ':0', 07:32:27 INFO - 'HOME': '/home/cltbld', 07:32:27 INFO - 'LANG': 'en_US.UTF-8', 07:32:27 INFO - 'LANGUAGE': 'en_US:en', 07:32:27 INFO - 'LOGNAME': 'cltbld', 07:32:27 INFO - 'MAIL': '/var/mail/cltbld', 07:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:27 INFO - 'MOZ_NO_REMOTE': '1', 07:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:27 INFO - 'NO_EM_RESTART': '1', 07:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:27 INFO - 'SHELL': '/bin/bash', 07:32:27 INFO - 'SHLVL': '1', 07:32:27 INFO - 'TERM': 'linux', 07:32:27 INFO - 'TMOUT': '86400', 07:32:27 INFO - 'USER': 'cltbld', 07:32:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:27 INFO - '_': '/tools/buildbot/bin/python'} 07:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:28 INFO - Downloading/unpacking psutil>=0.7.1 07:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:29 INFO - Installing collected packages: psutil 07:32:29 INFO - Running setup.py install for psutil 07:32:29 INFO - building 'psutil._psutil_linux' extension 07:32:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:32:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:32:30 INFO - building 'psutil._psutil_posix' extension 07:32:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:32:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:32:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:30 INFO - Successfully installed psutil 07:32:30 INFO - Cleaning up... 07:32:30 INFO - Return code: 0 07:32:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:30 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 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:30 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 07:32:30 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 07:32:30 INFO - Using env: {'DISPLAY': ':0', 07:32:30 INFO - 'HOME': '/home/cltbld', 07:32:30 INFO - 'LANG': 'en_US.UTF-8', 07:32:30 INFO - 'LANGUAGE': 'en_US:en', 07:32:30 INFO - 'LOGNAME': 'cltbld', 07:32:30 INFO - 'MAIL': '/var/mail/cltbld', 07:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:30 INFO - 'MOZ_NO_REMOTE': '1', 07:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:30 INFO - 'NO_EM_RESTART': '1', 07:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:30 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:30 INFO - 'SHELL': '/bin/bash', 07:32:30 INFO - 'SHLVL': '1', 07:32:30 INFO - 'TERM': 'linux', 07:32:30 INFO - 'TMOUT': '86400', 07:32:30 INFO - 'USER': 'cltbld', 07:32:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:30 INFO - '_': '/tools/buildbot/bin/python'} 07:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:32:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:32:32 INFO - Installing collected packages: mozsystemmonitor 07:32:32 INFO - Running setup.py install for mozsystemmonitor 07:32:32 INFO - Successfully installed mozsystemmonitor 07:32:32 INFO - Cleaning up... 07:32:32 INFO - Return code: 0 07:32:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:32 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 07:32:32 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 07:32:32 INFO - Using env: {'DISPLAY': ':0', 07:32:32 INFO - 'HOME': '/home/cltbld', 07:32:32 INFO - 'LANG': 'en_US.UTF-8', 07:32:32 INFO - 'LANGUAGE': 'en_US:en', 07:32:32 INFO - 'LOGNAME': 'cltbld', 07:32:32 INFO - 'MAIL': '/var/mail/cltbld', 07:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:32 INFO - 'MOZ_NO_REMOTE': '1', 07:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:32 INFO - 'NO_EM_RESTART': '1', 07:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:32 INFO - 'SHELL': '/bin/bash', 07:32:32 INFO - 'SHLVL': '1', 07:32:32 INFO - 'TERM': 'linux', 07:32:32 INFO - 'TMOUT': '86400', 07:32:32 INFO - 'USER': 'cltbld', 07:32:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:32 INFO - '_': '/tools/buildbot/bin/python'} 07:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:32:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:35 INFO - Downloading docopt-0.6.1.tar.gz 07:32:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:35 INFO - Running setup.py install for blobuploader 07:32:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:32:35 INFO - Running setup.py install for requests 07:32:35 INFO - Running setup.py install for docopt 07:32:35 INFO - Successfully installed blobuploader requests docopt 07:32:35 INFO - Cleaning up... 07:32:36 INFO - Return code: 0 07:32:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:36 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 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:36 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 07:32:36 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 07:32:36 INFO - Using env: {'DISPLAY': ':0', 07:32:36 INFO - 'HOME': '/home/cltbld', 07:32:36 INFO - 'LANG': 'en_US.UTF-8', 07:32:36 INFO - 'LANGUAGE': 'en_US:en', 07:32:36 INFO - 'LOGNAME': 'cltbld', 07:32:36 INFO - 'MAIL': '/var/mail/cltbld', 07:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:36 INFO - 'MOZ_NO_REMOTE': '1', 07:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:36 INFO - 'NO_EM_RESTART': '1', 07:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:36 INFO - 'SHELL': '/bin/bash', 07:32:36 INFO - 'SHLVL': '1', 07:32:36 INFO - 'TERM': 'linux', 07:32:36 INFO - 'TMOUT': '86400', 07:32:36 INFO - 'USER': 'cltbld', 07:32:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:36 INFO - '_': '/tools/buildbot/bin/python'} 07:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:32:36 INFO - Running setup.py (path:/tmp/pip-_DYyY5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:32:36 INFO - Running setup.py (path:/tmp/pip-6cQ2nS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:32:36 INFO - Running setup.py (path:/tmp/pip-O0aHNg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:32:36 INFO - Running setup.py (path:/tmp/pip-fWBP_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:32:36 INFO - Running setup.py (path:/tmp/pip-W0XgTM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:32:36 INFO - Running setup.py (path:/tmp/pip-0Ue0MY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:32:36 INFO - Running setup.py (path:/tmp/pip-jcr79q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:32:36 INFO - Running setup.py (path:/tmp/pip-mOGDdo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:32:36 INFO - Running setup.py (path:/tmp/pip-6bYaYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:32:36 INFO - Running setup.py (path:/tmp/pip-KBlu4B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:32:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:32:36 INFO - Running setup.py (path:/tmp/pip-boeXMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:32:37 INFO - Running setup.py (path:/tmp/pip-HqoYmT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:32:37 INFO - Running setup.py (path:/tmp/pip-AlLsEo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:32:37 INFO - Running setup.py (path:/tmp/pip-1AVgqO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:32:37 INFO - Running setup.py (path:/tmp/pip-jNm2h5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:32:37 INFO - Running setup.py (path:/tmp/pip-z6P9Mv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:32:37 INFO - Running setup.py (path:/tmp/pip-dV6AWK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:32:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:37 INFO - Running setup.py install for manifestparser 07:32:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:32:37 INFO - Running setup.py install for mozcrash 07:32:37 INFO - Running setup.py install for mozdebug 07:32:37 INFO - Running setup.py install for mozdevice 07:32:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:32:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:32:37 INFO - Running setup.py install for mozfile 07:32:38 INFO - Running setup.py install for mozhttpd 07:32:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Running setup.py install for mozinfo 07:32:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Running setup.py install for mozInstall 07:32:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Running setup.py install for mozleak 07:32:38 INFO - Running setup.py install for mozlog 07:32:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Running setup.py install for moznetwork 07:32:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Running setup.py install for mozprocess 07:32:38 INFO - Running setup.py install for mozprofile 07:32:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Running setup.py install for mozrunner 07:32:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:32:38 INFO - Running setup.py install for mozscreenshot 07:32:39 INFO - Running setup.py install for moztest 07:32:39 INFO - Running setup.py install for mozversion 07:32:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:32:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:39 INFO - Cleaning up... 07:32:39 INFO - Return code: 0 07:32:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:32: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')]} 07:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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/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 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:39 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 07:32:39 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 07:32:39 INFO - Using env: {'DISPLAY': ':0', 07:32:39 INFO - 'HOME': '/home/cltbld', 07:32:39 INFO - 'LANG': 'en_US.UTF-8', 07:32:39 INFO - 'LANGUAGE': 'en_US:en', 07:32:39 INFO - 'LOGNAME': 'cltbld', 07:32:39 INFO - 'MAIL': '/var/mail/cltbld', 07:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:39 INFO - 'MOZ_NO_REMOTE': '1', 07:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:39 INFO - 'NO_EM_RESTART': '1', 07:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:39 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:39 INFO - 'SHELL': '/bin/bash', 07:32:39 INFO - 'SHLVL': '1', 07:32:39 INFO - 'TERM': 'linux', 07:32:39 INFO - 'TMOUT': '86400', 07:32:39 INFO - 'USER': 'cltbld', 07:32:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:39 INFO - '_': '/tools/buildbot/bin/python'} 07:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:32:39 INFO - Running setup.py (path:/tmp/pip-JyR8un-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:32:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:32:39 INFO - Running setup.py (path:/tmp/pip-REatdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:32:39 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)) 07:32:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:32:39 INFO - Running setup.py (path:/tmp/pip-GL5qse-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:32:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:32:39 INFO - Running setup.py (path:/tmp/pip-930nYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:32:39 INFO - Running setup.py (path:/tmp/pip-XIoxK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:32:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:32:39 INFO - Running setup.py (path:/tmp/pip-DkmgC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:32:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:32:39 INFO - Running setup.py (path:/tmp/pip-L_Z2W9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:32:40 INFO - Running setup.py (path:/tmp/pip-DhLgT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:32:40 INFO - Running setup.py (path:/tmp/pip-Lxkw7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:32:40 INFO - Running setup.py (path:/tmp/pip-e6MfmE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:32:40 INFO - Running setup.py (path:/tmp/pip-Y61_L4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:32:40 INFO - Running setup.py (path:/tmp/pip-J0XM35-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:32:40 INFO - Running setup.py (path:/tmp/pip-or7INp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:32:40 INFO - Running setup.py (path:/tmp/pip-XsyQ3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:32:40 INFO - Running setup.py (path:/tmp/pip-ZTH8pG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:32:40 INFO - Running setup.py (path:/tmp/pip-0i0vC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:32:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:32:40 INFO - Running setup.py (path:/tmp/pip-Qh5C5W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:32:40 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)) 07:32:40 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)) 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:42 INFO - Downloading blessings-1.6.tar.gz 07:32:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:32:42 INFO - Installing collected packages: blessings 07:32:42 INFO - Running setup.py install for blessings 07:32:42 INFO - Successfully installed blessings 07:32:42 INFO - Cleaning up... 07:32:42 INFO - Return code: 0 07:32:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:32:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:32:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:32:43 INFO - Reading from file tmpfile_stdout 07:32:43 INFO - Current package versions: 07:32:43 INFO - argparse == 1.2.1 07:32:43 INFO - blessings == 1.6 07:32:43 INFO - blobuploader == 1.2.4 07:32:43 INFO - docopt == 0.6.1 07:32:43 INFO - manifestparser == 1.1 07:32:43 INFO - mozInstall == 1.12 07:32:43 INFO - mozcrash == 0.17 07:32:43 INFO - mozdebug == 0.1 07:32:43 INFO - mozdevice == 0.48 07:32:43 INFO - mozfile == 1.2 07:32:43 INFO - mozhttpd == 0.7 07:32:43 INFO - mozinfo == 0.9 07:32:43 INFO - mozleak == 0.1 07:32:43 INFO - mozlog == 3.1 07:32:43 INFO - moznetwork == 0.27 07:32:43 INFO - mozprocess == 0.22 07:32:43 INFO - mozprofile == 0.28 07:32:43 INFO - mozrunner == 6.11 07:32:43 INFO - mozscreenshot == 0.1 07:32:43 INFO - mozsystemmonitor == 0.0 07:32:43 INFO - moztest == 0.7 07:32:43 INFO - mozversion == 1.4 07:32:43 INFO - psutil == 3.1.1 07:32:43 INFO - requests == 1.2.3 07:32:43 INFO - wsgiref == 0.1.2 07:32:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 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 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:43 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 07:32:43 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 07:32:43 INFO - Using env: {'DISPLAY': ':0', 07:32:43 INFO - 'HOME': '/home/cltbld', 07:32:43 INFO - 'LANG': 'en_US.UTF-8', 07:32:43 INFO - 'LANGUAGE': 'en_US:en', 07:32:43 INFO - 'LOGNAME': 'cltbld', 07:32:43 INFO - 'MAIL': '/var/mail/cltbld', 07:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:43 INFO - 'MOZ_NO_REMOTE': '1', 07:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:43 INFO - 'NO_EM_RESTART': '1', 07:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:43 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:43 INFO - 'SHELL': '/bin/bash', 07:32:43 INFO - 'SHLVL': '1', 07:32:43 INFO - 'TERM': 'linux', 07:32:43 INFO - 'TMOUT': '86400', 07:32:43 INFO - 'USER': 'cltbld', 07:32:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:43 INFO - '_': '/tools/buildbot/bin/python'} 07:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:32:43 INFO - Cleaning up... 07:32:43 INFO - Return code: 0 07:32:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 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 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:43 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 07:32:43 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 07:32:43 INFO - Using env: {'DISPLAY': ':0', 07:32:43 INFO - 'HOME': '/home/cltbld', 07:32:43 INFO - 'LANG': 'en_US.UTF-8', 07:32:43 INFO - 'LANGUAGE': 'en_US:en', 07:32:43 INFO - 'LOGNAME': 'cltbld', 07:32:43 INFO - 'MAIL': '/var/mail/cltbld', 07:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:43 INFO - 'MOZ_NO_REMOTE': '1', 07:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:43 INFO - 'NO_EM_RESTART': '1', 07:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:43 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:43 INFO - 'SHELL': '/bin/bash', 07:32:43 INFO - 'SHLVL': '1', 07:32:43 INFO - 'TERM': 'linux', 07:32:43 INFO - 'TMOUT': '86400', 07:32:43 INFO - 'USER': 'cltbld', 07:32:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:43 INFO - '_': '/tools/buildbot/bin/python'} 07:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:43 INFO - Downloading/unpacking jsonschema 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:45 INFO - Downloading/unpacking functools32 (from jsonschema) 07:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:45 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:45 INFO - warning: no files found matching '*.txt' 07:32:45 INFO - no previously-included directories found matching 'build' 07:32:45 INFO - no previously-included directories found matching 'dist' 07:32:45 INFO - no previously-included directories found matching '.git*' 07:32:45 INFO - Installing collected packages: jsonschema, functools32 07:32:45 INFO - Running setup.py install for functools32 07:32:45 INFO - warning: no files found matching '*.txt' 07:32:45 INFO - no previously-included directories found matching 'build' 07:32:45 INFO - no previously-included directories found matching 'dist' 07:32:45 INFO - no previously-included directories found matching '.git*' 07:32:45 INFO - Successfully installed jsonschema functools32 07:32:45 INFO - Cleaning up... 07:32:45 INFO - Return code: 0 07:32:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f151ccd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:32:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:32:45 INFO - Using env: {'DISPLAY': ':0', 07:32:45 INFO - 'HOME': '/home/cltbld', 07:32:45 INFO - 'LANG': 'en_US.UTF-8', 07:32:45 INFO - 'LANGUAGE': 'en_US:en', 07:32:45 INFO - 'LOGNAME': 'cltbld', 07:32:45 INFO - 'MAIL': '/var/mail/cltbld', 07:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:45 INFO - 'MOZ_NO_REMOTE': '1', 07:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:45 INFO - 'NO_EM_RESTART': '1', 07:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:32:45 INFO - 'PWD': '/builds/slave/test-pgo', 07:32:45 INFO - 'SHELL': '/bin/bash', 07:32:45 INFO - 'SHLVL': '1', 07:32:45 INFO - 'TERM': 'linux', 07:32:45 INFO - 'TMOUT': '86400', 07:32:45 INFO - 'USER': 'cltbld', 07:32:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:45 INFO - '_': '/tools/buildbot/bin/python'} 07:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:45 INFO - Downloading/unpacking flake8 07:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:32:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:32:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:32:48 INFO - no previously-included directories found matching 'docs/_build' 07:32:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:32:48 INFO - Running setup.py install for pep8 07:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:32:48 INFO - no previously-included directories found matching 'docs/_build' 07:32:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:32:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:32:48 INFO - Cleaning up... 07:32:48 INFO - Return code: 0 07:32:48 INFO - Running post-action listener: _resource_record_post_action 07:32:48 INFO - Running post-action listener: _start_resource_monitoring 07:32:48 INFO - Starting resource monitoring. 07:32:48 INFO - ##### 07:32:48 INFO - ##### Running install step. 07:32:48 INFO - ##### 07:32:48 INFO - Running pre-action listener: _resource_record_pre_action 07:32:48 INFO - Running main action method: install 07:32:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:32:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:32:49 INFO - Reading from file tmpfile_stdout 07:32:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:32:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:32:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:32:49 INFO - Reading from file tmpfile_stdout 07:32:49 INFO - Output received: 07:32:49 INFO - Usage: mozinstall [options] installer 07:32:49 INFO - Options: 07:32:49 INFO - -h, --help show this help message and exit 07:32:49 INFO - -d DEST, --destination=DEST 07:32:49 INFO - Directory to install application into. [default: 07:32:49 INFO - "/builds/slave/test-pgo"] 07:32:49 INFO - --app=APP Application being installed. [default: firefox] 07:32:49 INFO - mkdir: /builds/slave/test-pgo/build/application 07:32:49 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'] 07:32:49 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 07:33:05 INFO - Reading from file tmpfile_stdout 07:33:05 INFO - Output received: 07:33:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:33:05 INFO - Running post-action listener: _resource_record_post_action 07:33:05 INFO - ##### 07:33:05 INFO - ##### Running run-tests step. 07:33:05 INFO - ##### 07:33:05 INFO - Running pre-action listener: _resource_record_pre_action 07:33:05 INFO - Running main action method: run_tests 07:33:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:33:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:33:05 INFO - Python 2.7.3 07:33:05 INFO - Return code: 0 07:33:05 INFO - grabbing minidump binary from tooltool 07:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:05 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 0xd8c920>, '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 0xd8d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8dcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:33:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:33:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:33:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:05 INFO - Return code: 0 07:33:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:33:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:33:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:33:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:33:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:33:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:33:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:33:06 INFO - Return code: 0 07:33:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 07:33:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:33:06 INFO - Using env: {'DISPLAY': ':0', 07:33:06 INFO - 'HOME': '/home/cltbld', 07:33:06 INFO - 'LANG': 'en_US.UTF-8', 07:33:06 INFO - 'LANGUAGE': 'en_US:en', 07:33:06 INFO - 'LOGNAME': 'cltbld', 07:33:06 INFO - 'MAIL': '/var/mail/cltbld', 07:33:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:33:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:06 INFO - 'MOZ_NO_REMOTE': '1', 07:33:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:06 INFO - 'NO_EM_RESTART': '1', 07:33:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:33:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:33:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:33:06 INFO - 'SHELL': '/bin/bash', 07:33:06 INFO - 'SHLVL': '1', 07:33:06 INFO - 'TERM': 'linux', 07:33:06 INFO - 'TMOUT': '86400', 07:33:06 INFO - 'USER': 'cltbld', 07:33:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060', 07:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:06 INFO - '_': '/tools/buildbot/bin/python'} 07:33:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:33:06 INFO - mozversion application_buildid: 20160309043048 07:33:06 INFO - mozversion application_changeset: 5143234fc6be8c842fa6ac7df75260fa7d43cfaa 07:33:06 INFO - mozversion application_display_name: Nightly 07:33:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:06 INFO - mozversion application_name: Firefox 07:33:06 INFO - mozversion application_remotingname: firefox 07:33:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:33:06 INFO - mozversion application_vendor: Mozilla 07:33:06 INFO - mozversion application_version: 48.0a1 07:33:06 INFO - mozversion platform_buildid: 20160309043048 07:33:06 INFO - mozversion platform_changeset: 5143234fc6be8c842fa6ac7df75260fa7d43cfaa 07:33:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:33:06 INFO - mozversion platform_version: 48.0a1 07:33:06 INFO - using testdate: 1457537586 07:33:06 INFO - actual date: 1457537586 07:33:06 INFO - starting webserver on 'localhost:58955' 07:33:06 INFO - SUITE-START | Running 2 tests 07:33:06 INFO - TEST-START | dromaeo_css 07:33:06 INFO - operating with platform_type : linux_ 07:33:06 INFO - Initialising browser for dromaeo_css test... 07:33:06 INFO - TEST-INFO | started process 4251 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoegA_3/profile http://localhost:58955/getInfo.html) 07:33:10 INFO - PROCESS | 4251 | 07:33:10 INFO - PROCESS | 4251 | (process:4333): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:33:10 INFO - PROCESS | 4251 | __metrics Screen width/height:1600/1200 07:33:10 INFO - PROCESS | 4251 | colorDepth:24 07:33:10 INFO - PROCESS | 4251 | Browser inner width/height: 1024/697 07:33:10 INFO - PROCESS | 4251 | __metrics 07:33:11 ERROR - PROCESS | 4251 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 07:33:12 INFO - TEST-INFO | 4251: exit 0 07:33:12 INFO - Browser initialized. 07:33:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:12 INFO - TEST-INFO | started process 4385 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoegA_3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:14 INFO - PROCESS | 4385 | 07:33:14 INFO - PROCESS | 4385 | (process:4446): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:33:24 INFO - PROCESS | 4385 | RSS: Main: 164409344 07:33:24 INFO - PROCESS | 4385 | 07:34:13 INFO - PROCESS | 4385 | 1457537653772 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:36:22 INFO - PROCESS | 4385 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58955/tests/dromaeo/cssquery-ext.html) 07:36:23 INFO - PROCESS | 4385 | RSS: Main: 169426944 07:36:23 INFO - PROCESS | 4385 | 07:39:25 INFO - PROCESS | 4385 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-ext.html (next: http://localhost:58955/tests/dromaeo/cssquery-jquery.html) 07:39:26 INFO - PROCESS | 4385 | RSS: Main: 168103936 07:39:26 INFO - PROCESS | 4385 | 07:42:28 INFO - PROCESS | 4385 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58955/tests/dromaeo/cssquery-mootools.html) 07:42:29 INFO - PROCESS | 4385 | RSS: Main: 170188800 07:42:29 INFO - PROCESS | 4385 | 07:45:30 INFO - PROCESS | 4385 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58955/tests/dromaeo/cssquery-prototype.html) 07:45:31 INFO - PROCESS | 4385 | RSS: Main: 167260160 07:45:31 INFO - PROCESS | 4385 | 07:48:34 INFO - PROCESS | 4385 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58955/tests/dromaeo/cssquery-yui.html) 07:48:34 INFO - PROCESS | 4385 | RSS: Main: 167686144 07:48:34 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-yui.html (next: http://localhost:58955/tests/dromaeo/cssquery-dojo.html) 07:51:37 INFO - PROCESS | 4385 | RSS: Main: 171737088 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | __start_tp_report 07:51:37 INFO - PROCESS | 4385 | _x_x_mozilla_page_load 07:51:37 INFO - PROCESS | 4385 | _x_x_mozilla_page_load_details 07:51:37 INFO - PROCESS | 4385 | |i|pagename|runs| 07:51:37 INFO - PROCESS | 4385 | |0;dojo.html;3165.509346051362;3242.7081562659355;3262.9510557341646;3268.035929400828;3275.2958114005482;5267.710275934832;5301.7084060376665;5311.07056265154;5327.0943939530325;5339.919901201481;5147.124988751912;5316.229146773716;5347.866303342418;5402.027635025694;5431.158170483582;4873.171560834667;4882.755862206894;4919.26211068339;4986.626003049786;5080.212567052113;4892.9510704892855;4896.534829191221;4932.8520144395725;4941.728204948727;4944.184209605411;4771.045790841846;4874.829380971684;4924.729139897304;4946.3817022872145;4967.7019378837385;4885.047415753929;4890.413150421972;4890.926636100461;4898.21628539432;4950.455449900508;4759.714417134983;4858.684185527929;4874.610031197496;4892.681975671606;4907.656464047518;5192.6105542084115;5242.292290540767;5248.606354523387;5255.106631872591;5283.656562323436;5742.7415766290615;5770.2210201622665;5773.682447465388;5781.82654520365;5783;5619.971900140514;5716.971415142939;5796.391378905197;5800.303963524362;5814.709264536798;5369.3556773187465;5377.78488860449;5384.703841288728;5392.703401312926;5394.487523685244;5846.327672317653;5848.473637372572;5850.707464626752;5855.473007429352;5857.297124345106;5547.16792481123;5615.073512870331;5647;5674.687892165971;5696.800611978644;5624.887502249932;5734.913976290359;5776.653400795965;5785.71071446426;5786.103154011051;5572.58205634579;5587.664740115606;5631.042722737145;5659.5755318351285;5674.546036317085;5472.945270547243;5651.463111004448;5699.116636921284;5711.7144142792695;5758.74085666146;4281.571842815693;4296.914061718748;4303.677224208197;4308.267594508941;4339.826406943687;3870.2453021661067;3886.106195575034;3889.105505733697;3902.2585708715255;3932;5312.282841816383;5367.302250707383;5432.103702888979;5453;5512.062949298629;5714.314282286152;5725.141228815711;5733.283339582552;5743.770249189985;5764.942350576441;5420.24116623673;5428.972855135699;5438.646487978269;5451.536619387317;5456.491788004642;4772.141014617333;4821.783019764119;4846.200376937836;4848.3697119374965;4897.314375987294;5930.229070220844;5949.0481522956115;5979.431953964367;5985.670788106609;5989.820305390933;5577.051901176728;5701.800436984686;5713.542916566747;5719.57103217252;5727.942720572741;5991.700414979321;6005.339412664691;6039.396060394101;6047.667378294236;6069.484093852072;5685.744141513725;5694.402087780723;5704.372519022987;5707.915496055736;5726.770929162787;5683.715814209356;5791.0734282514595;5797.826065218051;5798.188253644577;5809.157672137432;5533.474319939599;5561.776409189972;5580.665160090245;5646.153077038477;5686.744096515584;5428.212909128233;5528.778848846001;5536.169574563848;5549.611527193219;5551.084071128219;5427.4301198373605;5452.781888724565;5455;5461.9453805461435;5502.504774570308;5536;5550.2507161534295;5579.721013949367;5579.939811435815;5586.720663966867;5443.755031023693;5487.862803429946;5488.533474654699;5490.0941344677685;5491.862703432446 07:51:37 INFO - PROCESS | 4385 | |1;ext.html;534.2360424592831;544.8202093309208;563.5547917145457;582.9941700582998;604.356360476093;37458.62541374585;37597;37796;37810.621893781055;37897.621023789754;40750.18499630006;41346;41458.79270603643;41638.58361416385;41642.37536436956;8565.528895910722;8711.651533938666;8734.563271836383;8748.343874209428;8755.25580325673;8794.164554367357;8929.419587726778;8951.418157819753;8966.506842123681;8973.416727912698;8874.778130546756;8929.866052009193;8945.55272236389;8976.326775491863;9017.143371379709;8870.37907346486;8935.374523783337;8954.462732236087;8954.597043133075;8962.327825413055;8857;8952.657101434772;8960.820783584357;8966.148215919477;8987.865182022275;41513.547025854255;41806.37290440646;42004.78997605023;42015;42102.789486052374;2800.7339302766204;3293.176705823544;3510.3330367230146;3609;3693.5013773140818;27523.174304770888;27669.446611067866;27963;28283.434331313463;28381.290467738472;3814.828332725034;3835.5013848199833;3877.0888841122314;3938.862139825121;3986.820593073319;187473;187563;188826;188937.05531472393;189708;54135.458645413826;54157.45842541603;54217.72891135519;54224.18663720047;54257;63075;70494;70824.2917570828;70962.64518677373;71033.64483177551;14519.78220326696;14586.708265834835;14662.926685366505;14693.26533673312;14731;10311.84532232017;10320.48397580133;10329.276950613536;10333.121684656888;10337.896621033844;20609.969501524865;20946.057427415803;21022.684659730116;21077.36767896935;21121.471963201042;7836.7461206206735;7988.520688758576;8035.678572857137;8035.839283214303;8177.141400152898;805.2752522729473;826.5536610230529;917.564157025421;951.8191543606692;959.822432849925;27753.722462775113;28616.570751438747;29804.40391192164;29927.251818704706;31431.52852707211;981.3081777346953;1012.7063151686076;1037.040737317993;1042.8227201375785;1078.126717358926;12366.505339786489;12886.355682215852;14107.083039602392;14345.497907573394;14403.135811851322;263834;265648;269466;270247;270363;50359.49640503621;50370.74814625904;50838;50991.490085099416;51052;919.72868003939;1329.3619062849887;1336.1181620130862;1337.2645045225088;1341.2556031402664;20673.689894651292;26152.476950460503;26204.344891377867;26425.471490569696;26444.603330949667;46696.766516167205;46751.53248467472;46774.298385523565;46800;47220.7638961803;321106;322524;322567;323627;323631;33141;33850.83074584611;33885;34082;34117.147071322426;44210.55789442064;45703;45706.54293457156;46704;46852.7657361711;37463.81268093642;38886.61113388943;39599.2080158401;41224;41314.58685413228;35697.1075723109;36869.81565092158;37054.629453705114;40799.38800917929;41094;35863.10342241465;37531.24937501289;37549.249015019;38280.234395312495;38438;29849.5522567166;31229.531557027116;31515.684843151274;31923.521147183274;33424.33151336911;21060.894695526425;24293.757062429857;27721.44557108887;28062.85968570144;28279.71720282771 07:51:37 INFO - PROCESS | 4385 | |2;jquery.html;348.1835096698243;356.3283211146989;366.543653151826;371.7174947040249;373.9270842185775;16245.675086498262;16576.419825306115;17358.21888015039;17369.47891563252;17372.391966281182;15095.698086038301;15130.924345378258;15197.24013799311;15223.162726050063;15462.304196311165;4549.158405694949;4767.070421267854;4797;4800.375951126366;4824.951750482485;4756.35789168463;4760.928586071212;4794.544518270759;4812.0375924815;4815.205491093965;4774.8090076397075;4777.5222477752295;4786.545278198566;4786.83246086387;4792.592629626486;4642.286171063136;4709.152352576535;4754.334393184957;4769.737664428455;4927;4824.831130910401;4854.927176092361;4874.341963834908;4889.706617602955;4895.7062576245535;12806;12857;12934.54729084487;13004.414801333867;13017.544385946541;2061.309461330456;2083.5520363122;2106.7471903371693;2108.5045014421753;2159.4601349662585;9076.591553380114;9248.306377021683;9286.071392860727;9499.620015199383;9584.37701549397;1765.1527266911953;1775.7602723632274;1796.1917137288272;1843.6773564626137;1853.5458812590866;60649;66823.3317666822;67944.6602766983;69044.6547767263;69396;10269.948650256702;10343.896561034293;10433.634822781318;10628.14974802014;10740.838887416696;14064.578062658136;14162.64593385153;14232.359543820552;14257.144571325754;14269;7206;7523.699052037857;7555.622218889033;7561.697532098765;7620.428467864932;7065.0815393998455;7134.785956421316;7204.53170543913;7263.818404539928;7291.781246562611;4427.446569178853;4428.047969686533;4455.6212721918355;4491.348754430589;4504.797284122223;1796.6761491241361;1826.1508398594717;1834.4221570205343;1862.394721715448;1881.7741870975572;836.5691668790578;899.4648184330313;922.6171138977384;928.4893308680333;932.4638332958576;15839.524814255361;16761.83238167627;17025.914870425815;17372.565685857702;17790.644187116184;899.4558292233236;915.3592485260344;942.4816351006918;950.6102497975935;1001.0840081325506;8613.397062205711;9493.240540756722;9508.524573771283;9661.951690241644;10240.283180177465;416828;431415;439230;441668;442938;56688;63451;66878;72455.2754472459;74423;904.7828521155008;944.6693657219918;962.0235461007084;968.1915600473683;985.1773768903046;14384.856151438351;14699.853001469848;14763.778543321643;15238.542843714706;15856.52430427089;31984.6801531991;32769;33468.66531334655;33698.15754606057;33761.831190844874;42378;42439.151216976104;42472;44473.332900007175;47132.7643361781;8078.87881681787;8150.470219435718;8370.204830541088;8371.41400101987;8502.702405415781;11507.769844603228;12607.802258785767;13349.199048057148;13359;13361.866381336451;10014.186515343778;10506.527206275583;10877.67366978992;10933;10942.945285273523;9794.65718699842;10235.641752538626;10521.526531305957;10602.681919542427;11118.777624447628;10223.539940702834;11508.136889733136;11629.360385178896;11783.52865885355;11839.408029598313;8151.551664658501;8161.224683655043;8167.959160204398;8170.101288858102;8179.10029896699;10231.84652230232;10608.575656973635;10736.194785390971;10908.072813810915;11515.366654834064 07:51:37 INFO - PROCESS | 4385 | |3;mootools.html;1435.9353829077693;1440.4598275646633;1623.0910690013593;1788.2846861255505;1807.602327487953;7090.539114957524;7632.580208088553;7902.091259505151;8065.91934080659;8073.152319006501;7775.805604859881;7867.291943725064;7933.801654958615;7940.047194336687;7988.121306656263;2151.860129091608;2168.718066651333;2171.5005548723802;2180.193328468461;2182.170775105458;2225.788550087739;2248.2693124734446;2280.429892526868;2284.8286378521593;2289.244549298736;2264.6942662740485;2290.530441259546;2304.9193278235266;2311.179531266401;2321.2688003279;2203.5703037907615;2208.3374987503685;2211.07135003299;2221.7889300516504;2230.955380892373;2280.2247235939694;2315.1549684365255;2316.9189078382346;2317.930462086123;2329.0683726509365;8019.518828870287;8108.472949258338;8112.945317108797;8118.675252989873;8143.104258531557;4518.186726389248;4561.270196768501;4566.703164294344;4573.748443835588;4595.402597662316;2956.024511911064;2993.266649670823;3151.952720709191;3175.952360714591;3183.1723751824693;961.846104623264;965.9565319560567;985.5269470654126;991;1006.1598565198068;11079.944600277107;11101;11128.221024528286;11155.944220278929;11171.497282622302;4227.7463352198965;4266.381374700651;4304.89237769052;4318.654507639381;4331.761753103547;9426.387284826464;9435.339526233098;9435.52822358893;9452.43285402878;9484.0515948406;4708.788104535304;4708.976455117771;4731.313959475926;4762.333273341735;4771.379720636364;3925.9607403926166;4217.072244106292;4229.7250678706405;4291.957080429156;4322.697411181187;3668.761530500509;3701.3152566775234;3764.7741135531955;3792.2036372362113;3807.667316439224;1217.2392254840724;1229;1230.267990545624;1230.7569354951563;1233.2970206981934;1059.6238335390979;1063.5161001744343;1232.950681972729;1344.253939063829;1345.5626921250437;7492.887606685904;7569.697212111564;7584.317411432998;7624.390048796083;7761.8447631047065;1019.2406657040552;1062.7980683670078;1069.5775168808432;1071.737424331044;1073.2648136026846;6177.1969643945995;6181.412765787333;6263.279722831932;6266.530010249249;6269.247690277196;9499.952500237454;10017.749556261151;10037.297389182833;10037.397756134655;10070.244731645156;9761.170300524393;9880.555375008142;9888.752781180385;9948.104670579683;9958.601655933826;7362.374198193106;7440.888386674204;7488.5506869588;7537.095548534211;7613.6573854176695;7478.1774004858335;7581.658825352762;7606.657700403606;7621.618919054136;7622.16156222804;8298.70954516589;8561.529115898686;8586.570671466527;8619.1811777881;8694.260987815853;8564.314854811475;8761.868571971298;8821.117888211127;8875.334349923653;8922.73231803047;6081.939180608138;6740.157480314961;6938.8612227756175;6956.165260168812;7011.4741394394605;7656.73201437947;7681.807954801175;7691.923080769121;7720.729774457867;7750.92249077502;6599.835004124743;6676.732930682719;6717.093192418961;6734.898976515258;6740.528163028541;6704.66476676174;6772.05191273232;6934.306569343227;6988.091548098715;7013.894791578233;6878.793636190922;6884.311568843075;6901.516893817385;6905;6913.965430172817;6632.668366581748;6685.598864068172;6698.631575263213;6725.630090345078;6737.056812046219;6706.798796036127;6752;6777.254502004677;6780.355866192901;6800.557963732342 07:51:37 INFO - PROCESS | 4385 | |4;prototype.html;349.4147303267028;354.89885382665943;358.3013124407406;358.68077411104116;359.207946478016;6179.227596550426;6190.473809726173;6200.720967556459;6216.968915155424;6241.0950412190205;6156.692165391735;6177.505799536027;6185.134081228621;6190.752369905198;6199.597026193305;4634;4705.63536574393;4712;4730.645201609876;4790.592799612028;4710.952890471103;4729.929051064237;4737.478877323491;4747.121782470237;4747.7388743619085;4675.18184317743;4711.128441238365;4729.881752956169;4740;4740.383750112481;4727.196376615983;4732.195526760442;4734.19518681825;4751.4535828379485;4754.809807607691;4063.248299064653;4085.387191921206;4092.0997380576227;4102.323116685743;4134.131832315217;5886.558508111866;5897.144913987448;5899.941000589982;5905.763769449217;5914.852128696774;5435.184722291688;5559.416261292547;5564.443555644443;5566.4990150886615;5609.49514543693;6430;6454.93545064548;6558.573692710006;6587.374199451045;6605.273419923805;4676.602488788423;4706.694064885772;4715.033418149271;4718.103560323562;4730.053989202173;6812.4550035997;6831.6242606656615;6839.965800171017;6888.621125838077;6897.827554311132;4761.333413322138;4771.355866957916;4774.116788394158;4789.137955168103;4818.7831547580445;4836.854894353175;4859.392575928009;4861.0277944411255;4872.366592342973;4875.219964805614;5281.973590132025;5412;5422.267993820863;5430.266913966564;5586.190002449704;6477.935220647733;6501.0573466847045;6535.411812936859;6539.574927629784;6545.887199176152;1714.9056801876015;1741.521081702542;1741.9303227870744;1743.5466778637644;1745;1179.1392283632997;1183.5206741269799;1189.5360809284387;1207.806750919866;1219.1892391559513;6230.750769969241;6247.312795592481;6252.624842509464;6259.937400626027;6266.717997690115;6721.764738234237;6765.763198288037;6770.255271920085;6777.491688123312;6787.626680532618;6170.7223174957235;6273.372662733781;6302.054691796267;6367.42693157618;6382.6170429774365;3666.505021822073;3672.8347224374966;3681.5214022176947;3681.6870566001653;3682.650148235913;7185.89221161683;7186.856262874818;7192.82017949545;7195.532290401107;7195.676194571257;7017.824554386181;7020.087388639547;7026.754063607749;7039.436845052383;7060.92939070613;7130.750423735144;7212.4951253411755;7243.818904527324;7260.165081015645;7296.16094149169;6801.1158549388265;6818.727250909908;6823.624700641512;6829.941359089349;6833.863322733418;6738.696758645775;6750.548632044134;6750.966245168743;6760.391564759196;6766.966165169143;7237.3486386225495;7237.769579171448;7245.420366370572;7248.528845625017;7265.309795569412;4540.818367265272;4574.473935497461;4582.633389328779;4598.517155698737;4600.585947264763;6615.239247486601;6810.693518791567;6848.657567121524;6871.553349032297;6903.827404314731;6626.966865165836;6665.466762658879;6673.432758215606;6674.532782705164;6677.899831502628;6617.239017513048;6655.733770649314;6659.866802664016;6663.300353463011;6671.933280667326;6538.8365290868105;6540.771073012422;6541.672916354068;6547.672616369257;6557.409833115043;6685.431738302104;6686.465082793462;6692.933070669231;6710.194776626836;6725.058491811053;6522.445592124533;6540.8364790880605;6541.149650545399;6550.47596192313;6561.671916404065 07:51:37 INFO - PROCESS | 4385 | |5;yui.html;667.9565828221168;668.1280928388458;731.8572878288734;747.4991755523798;753.07371932523;12068.2759034458;12145.635630931076;12166.574169904055;12190.878091219085;12217.022638188946;12882.355882205899;13043.673908152301;13063.41214645341;13072.215667059983;13081.934590327035;654.5123882707389;801.8396320735847;810.7608255564622;816.6488409983705;820.6143112737004;801.6673080671543;805.814662627596;808.8948436703221;811.5333683132193;814.722994181978;859.995700021499;862.7368652560966;864.3171894203572;864.5029108262743;864.8572985457392;852.5737131434283;852.8720691896203;853.2320911179957;853.5945425922699;856.8500512410303;632.1907957814005;636.4653690899667;636.700750647195;638.1385130074409;639.0669622351372;12981.41583628739;13105.082644214908;13107.672308192372;13157.342132893316;13403.932980335134;12699.301538415384;12820.743585128339;12860.485580576858;12912;13034.543790967366;10143.797124057477;10248.391351264972;10465.9476702616;10516;10551.84172237417;3606.296772129436;3711.0722319420147;3712.2204337089242;3733.7386382953205;3746.3631182699005;48195.277070843964;48284;48287;48505.51494485081;48541;9540.236781057498;10067.949660251652;10082.445465499468;10384.221183411275;10388;16966.660666786844;17103.828961710224;17106.657866842594;17115.74326385105;17129.143542823058;7331.633418329062;7424.591647459333;7573.318401343906;7588.506747061423;7592.81017974555;4232.30167022444;4245.235857545671;4296.61330480252;4408.4269045024585;4444.799984000728;3172.428962786674;3197.0249074032645;3200.6159260888376;3215.887443939451;3219.2917558137174;531.7607076815449;543.0659266062366;544.6868050870766;551.3383939272888;554.1659801997968;602.7769725201616;625.1966223402906;626.7273735924887;648.4779752299349;649.2339039932924;8178.83642327162;8294.917050829536;8455.069942306342;8472.618732157067;9386.389884657476;469.11571687369553;475.7121941225509;487.0599742496944;622.1041699952145;681.5706105153721;3997.960020399759;4123;4274.038341373166;4460.375547423363;4510.72935623857;51799;54270;54769.904601907736;54817.451825481236;58251.4174858246;48789.756051220225;48794.268085978736;48856.26715599269;48871;49678.25482617764;46525.767371162925;46762.766186168854;46848;46877.531224688;46997.53002470068;7823.804404889924;8647.56762161902;8840.469571825453;8869.201771840308;8881.42270752399;32415.837920810245;33212.83393583017;33258.50112248366;33345.83327083349;34002.489962651074;38681.6131838678;38739.22521549497;38797.03007424724;39022.41466378063;39047;4358.210557389313;10682.8397574038;10744.623938162127;11006.339619622848;11334.773304534028;8868.33487488428;11322.094232461548;11334.433278335886;11378.829317560077;11483.25358851672;9900.603975840886;10439.060484556427;10699.985575512033;10924.399158046384;11161.49773260189;10522.842157367493;10528.210384221062;10657.360558366523;10967.561297548009;11102.666919992413;9553.283503737108;9657.130858222794;9697;9959.850602240827;10020.148287395654;8088.636011379384;8294.460860044319;8349.749507514784;8551.10213427606;8832.823343533222;7699.846003080019;7743.264389882952;7830.4518683691595;8380;8871.423357481743 07:51:37 INFO - PROCESS | 4385 | __end_tp_report 07:51:37 INFO - PROCESS | 4385 | __start_cc_report 07:51:37 INFO - PROCESS | 4385 | _x_x_mozilla_cycle_collect,342 07:51:37 INFO - PROCESS | 4385 | __end_cc_report 07:51:37 INFO - PROCESS | 4385 | __startTimestamp1457538697771__endTimestamp 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | ------- Summary: start ------- 07:51:37 INFO - PROCESS | 4385 | Number of tests: 6 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | [#0] dojo.html Cycles:165 Average:5318.01 Median:5488.53 stddev:593.14 (10.8%) stddev-sans-first:570.42 07:51:37 INFO - PROCESS | 4385 | Values: 3165.5 3242.7 3263.0 3268.0 3275.3 5267.7 5301.7 5311.1 5327.1 5339.9 5147.1 5316.2 5347.9 5402.0 5431.2 4873.2 4882.8 4919.3 4986.6 5080.2 4893.0 4896.5 4932.9 4941.7 4944.2 4771.0 4874.8 4924.7 4946.4 4967.7 4885.0 4890.4 4890.9 4898.2 4950.5 4759.7 4858.7 4874.6 4892.7 4907.7 5192.6 5242.3 5248.6 5255.1 5283.7 5742.7 5770.2 5773.7 5781.8 5783.0 5620.0 5717.0 5796.4 5800.3 5814.7 5369.4 5377.8 5384.7 5392.7 5394.5 5846.3 5848.5 5850.7 5855.5 5857.3 5547.2 5615.1 5647.0 5674.7 5696.8 5624.9 5734.9 5776.7 5785.7 5786.1 5572.6 5587.7 5631.0 5659.6 5674.5 5472.9 5651.5 5699.1 5711.7 5758.7 4281.6 4296.9 4303.7 4308.3 4339.8 3870.2 3886.1 3889.1 3902.3 3932.0 5312.3 5367.3 5432.1 5453.0 5512.1 5714.3 5725.1 5733.3 5743.8 5764.9 5420.2 5429.0 5438.6 5451.5 5456.5 4772.1 4821.8 4846.2 4848.4 4897.3 5930.2 5949.0 5979.4 5985.7 5989.8 5577.1 5701.8 5713.5 5719.6 5727.9 5991.7 6005.3 6039.4 6047.7 6069.5 5685.7 5694.4 5704.4 5707.9 5726.8 5683.7 5791.1 5797.8 5798.2 5809.2 5533.5 5561.8 5580.7 5646.2 5686.7 5428.2 5528.8 5536.2 5549.6 5551.1 5427.4 5452.8 5455.0 5461.9 5502.5 5536.0 5550.3 5579.7 5579.9 5586.7 5443.8 5487.9 5488.5 5490.1 5491.9 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | [#1] ext.html Cycles:180 Average:43873.65 Median:21047.53 stddev:69448.26 (330.0%) stddev-sans-first:69566.84 07:51:37 INFO - PROCESS | 4385 | Values: 534.2 544.8 563.6 583.0 604.4 37458.6 37597.0 37796.0 37810.6 37897.6 40750.2 41346.0 41458.8 41638.6 41642.4 8565.5 8711.7 8734.6 8748.3 8755.3 8794.2 8929.4 8951.4 8966.5 8973.4 8874.8 8929.9 8945.6 8976.3 9017.1 8870.4 8935.4 8954.5 8954.6 8962.3 8857.0 8952.7 8960.8 8966.1 8987.9 41513.5 41806.4 42004.8 42015.0 42102.8 2800.7 3293.2 3510.3 3609.0 3693.5 27523.2 27669.4 27963.0 28283.4 28381.3 3814.8 3835.5 3877.1 3938.9 3986.8 187473.0 187563.0 188826.0 188937.1 189708.0 54135.5 54157.5 54217.7 54224.2 54257.0 63075.0 70494.0 70824.3 70962.6 71033.6 14519.8 14586.7 14662.9 14693.3 14731.0 10311.8 10320.5 10329.3 10333.1 10337.9 20610.0 20946.1 21022.7 21077.4 21121.5 7836.7 7988.5 8035.7 8035.8 8177.1 805.3 826.6 917.6 951.8 959.8 27753.7 28616.6 29804.4 29927.3 31431.5 981.3 1012.7 1037.0 1042.8 1078.1 12366.5 12886.4 14107.1 14345.5 14403.1 263834.0 265648.0 269466.0 270247.0 270363.0 50359.5 50370.7 50838.0 50991.5 51052.0 919.7 1329.4 1336.1 1337.3 1341.3 20673.7 26152.5 26204.3 26425.5 26444.6 46696.8 46751.5 46774.3 46800.0 47220.8 321106.0 322524.0 322567.0 323627.0 323631.0 33141.0 33850.8 33885.0 34082.0 34117.1 44210.6 45703.0 45706.5 46704.0 46852.8 37463.8 38886.6 39599.2 41224.0 41314.6 35697.1 36869.8 37054.6 40799.4 41094.0 35863.1 37531.2 37549.2 38280.2 38438.0 29849.6 31229.5 31515.7 31923.5 33424.3 21060.9 24293.8 27721.4 28062.9 28279.7 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | [#2] jquery.html Cycles:180 Average:24724.82 Median:435322.50 stddev:71204.22 (16.4%) stddev-sans-first:71380.44 07:51:37 INFO - PROCESS | 4385 | Values: 348.2 356.3 366.5 371.7 373.9 16245.7 16576.4 17358.2 17369.5 17372.4 15095.7 15130.9 15197.2 15223.2 15462.3 4549.2 4767.1 4797.0 4800.4 4825.0 4756.4 4760.9 4794.5 4812.0 4815.2 4774.8 4777.5 4786.5 4786.8 4792.6 4642.3 4709.2 4754.3 4769.7 4927.0 4824.8 4854.9 4874.3 4889.7 4895.7 12806.0 12857.0 12934.5 13004.4 13017.5 2061.3 2083.6 2106.7 2108.5 2159.5 9076.6 9248.3 9286.1 9499.6 9584.4 1765.2 1775.8 1796.2 1843.7 1853.5 60649.0 66823.3 67944.7 69044.7 69396.0 10269.9 10343.9 10433.6 10628.1 10740.8 14064.6 14162.6 14232.4 14257.1 14269.0 7206.0 7523.7 7555.6 7561.7 7620.4 7065.1 7134.8 7204.5 7263.8 7291.8 4427.4 4428.0 4455.6 4491.3 4504.8 1796.7 1826.2 1834.4 1862.4 1881.8 836.6 899.5 922.6 928.5 932.5 15839.5 16761.8 17025.9 17372.6 17790.6 899.5 915.4 942.5 950.6 1001.1 8613.4 9493.2 9508.5 9662.0 10240.3 416828.0 431415.0 439230.0 441668.0 442938.0 56688.0 63451.0 66878.0 72455.3 74423.0 904.8 944.7 962.0 968.2 985.2 14384.9 14699.9 14763.8 15238.5 15856.5 31984.7 32769.0 33468.7 33698.2 33761.8 42378.0 42439.2 42472.0 44473.3 47132.8 8078.9 8150.5 8370.2 8371.4 8502.7 11507.8 12607.8 13349.2 13359.0 13361.9 10014.2 10506.5 10877.7 10933.0 10942.9 9794.7 10235.6 10521.5 10602.7 11118.8 10223.5 11508.1 11629.4 11783.5 11839.4 8151.6 8161.2 8168.0 8170.1 8179.1 10231.8 10608.6 10736.2 10908.1 11515.4 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | [#3] mootools.html Cycles:180 Average:5576.74 Median:6434.54 stddev:2943.59 (45.7%) stddev-sans-first:2935.39 07:51:37 INFO - PROCESS | 4385 | Values: 1435.9 1440.5 1623.1 1788.3 1807.6 7090.5 7632.6 7902.1 8065.9 8073.2 7775.8 7867.3 7933.8 7940.0 7988.1 2151.9 2168.7 2171.5 2180.2 2182.2 2225.8 2248.3 2280.4 2284.8 2289.2 2264.7 2290.5 2304.9 2311.2 2321.3 2203.6 2208.3 2211.1 2221.8 2231.0 2280.2 2315.2 2316.9 2317.9 2329.1 8019.5 8108.5 8112.9 8118.7 8143.1 4518.2 4561.3 4566.7 4573.7 4595.4 2956.0 2993.3 3152.0 3176.0 3183.2 961.8 966.0 985.5 991.0 1006.2 11079.9 11101.0 11128.2 11155.9 11171.5 4227.7 4266.4 4304.9 4318.7 4331.8 9426.4 9435.3 9435.5 9452.4 9484.1 4708.8 4709.0 4731.3 4762.3 4771.4 3926.0 4217.1 4229.7 4292.0 4322.7 3668.8 3701.3 3764.8 3792.2 3807.7 1217.2 1229.0 1230.3 1230.8 1233.3 1059.6 1063.5 1233.0 1344.3 1345.6 7492.9 7569.7 7584.3 7624.4 7761.8 1019.2 1062.8 1069.6 1071.7 1073.3 6177.2 6181.4 6263.3 6266.5 6269.2 9500.0 10017.7 10037.3 10037.4 10070.2 9761.2 9880.6 9888.8 9948.1 9958.6 7362.4 7440.9 7488.6 7537.1 7613.7 7478.2 7581.7 7606.7 7621.6 7622.2 8298.7 8561.5 8586.6 8619.2 8694.3 8564.3 8761.9 8821.1 8875.3 8922.7 6081.9 6740.2 6938.9 6956.2 7011.5 7656.7 7681.8 7691.9 7720.7 7750.9 6599.8 6676.7 6717.1 6734.9 6740.5 6704.7 6772.1 6934.3 6988.1 7013.9 6878.8 6884.3 6901.5 6905.0 6914.0 6632.7 6685.6 6698.6 6725.6 6737.1 6706.8 6752.0 6777.3 6780.4 6800.6 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | [#4] prototype.html Cycles:180 Average:5543.68 Median:6235.92 stddev:1668.44 (26.8%) stddev-sans-first:1626.94 07:51:37 INFO - PROCESS | 4385 | Values: 349.4 354.9 358.3 358.7 359.2 6179.2 6190.5 6200.7 6217.0 6241.1 6156.7 6177.5 6185.1 6190.8 6199.6 4634.0 4705.6 4712.0 4730.6 4790.6 4711.0 4729.9 4737.5 4747.1 4747.7 4675.2 4711.1 4729.9 4740.0 4740.4 4727.2 4732.2 4734.2 4751.5 4754.8 4063.2 4085.4 4092.1 4102.3 4134.1 5886.6 5897.1 5899.9 5905.8 5914.9 5435.2 5559.4 5564.4 5566.5 5609.5 6430.0 6454.9 6558.6 6587.4 6605.3 4676.6 4706.7 4715.0 4718.1 4730.1 6812.5 6831.6 6840.0 6888.6 6897.8 4761.3 4771.4 4774.1 4789.1 4818.8 4836.9 4859.4 4861.0 4872.4 4875.2 5282.0 5412.0 5422.3 5430.3 5586.2 6477.9 6501.1 6535.4 6539.6 6545.9 1714.9 1741.5 1741.9 1743.5 1745.0 1179.1 1183.5 1189.5 1207.8 1219.2 6230.8 6247.3 6252.6 6259.9 6266.7 6721.8 6765.8 6770.3 6777.5 6787.6 6170.7 6273.4 6302.1 6367.4 6382.6 3666.5 3672.8 3681.5 3681.7 3682.7 7185.9 7186.9 7192.8 7195.5 7195.7 7017.8 7020.1 7026.8 7039.4 7060.9 7130.8 7212.5 7243.8 7260.2 7296.2 6801.1 6818.7 6823.6 6829.9 6833.9 6738.7 6750.5 6751.0 6760.4 6767.0 7237.3 7237.8 7245.4 7248.5 7265.3 4540.8 4574.5 4582.6 4598.5 4600.6 6615.2 6810.7 6848.7 6871.6 6903.8 6627.0 6665.5 6673.4 6674.5 6677.9 6617.2 6655.7 6659.9 6663.3 6671.9 6538.8 6540.8 6541.7 6547.7 6557.4 6685.4 6686.5 6692.9 6710.2 6725.1 6522.4 6540.8 6541.1 6550.5 6561.7 07:51:37 INFO - PROCESS | 4385 | 07:51:37 INFO - PROCESS | 4385 | [#5] yui.html Cycles:180 Average:13182.13 Median:48239.64 stddev:15320.85 (31.8%) stddev-sans-first:15335.01 07:51:37 INFO - PROCESS | 4385 | Values: 668.0 668.1 731.9 747.5 753.1 12068.3 12145.6 12166.6 12190.9 12217.0 12882.4 13043.7 13063.4 13072.2 13081.9 654.5 801.8 810.8 816.6 820.6 801.7 805.8 808.9 811.5 814.7 860.0 862.7 864.3 864.5 864.9 852.6 852.9 853.2 853.6 856.9 632.2 636.5 636.7 638.1 639.1 12981.4 13105.1 13107.7 13157.3 13403.9 12699.3 12820.7 12860.5 12912.0 13034.5 10143.8 10248.4 10465.9 10516.0 10551.8 3606.3 3711.1 3712.2 3733.7 3746.4 48195.3 48284.0 48287.0 48505.5 48541.0 9540.2 10067.9 10082.4 10384.2 10388.0 16966.7 17103.8 17106.7 17115.7 17129.1 7331.6 7424.6 7573.3 7588.5 7592.8 4232.3 4245.2 4296.6 4408.4 4444.8 3172.4 3197.0 3200.6 3215.9 3219.3 531.8 543.1 544.7 551.3 554.2 602.8 625.2 626.7 648.5 649.2 8178.8 8294.9 8455.1 8472.6 9386.4 469.1 475.7 487.1 622.1 681.6 3998.0 4123.0 4274.0 4460.4 4510.7 51799.0 54270.0 54769.9 54817.5 58251.4 48789.8 48794.3 48856.3 48871.0 49678.3 46525.8 46762.8 46848.0 46877.5 46997.5 7823.8 8647.6 8840.5 8869.2 8881.4 32415.8 33212.8 33258.5 33345.8 34002.5 38681.6 38739.2 38797.0 39022.4 39047.0 4358.2 10682.8 10744.6 11006.3 11334.8 8868.3 11322.1 11334.4 11378.8 11483.3 9900.6 10439.1 10700.0 10924.4 11161.5 10522.8 10528.2 10657.4 10967.6 11102.7 9553.3 9657.1 9697.0 9959.9 10020.1 8088.6 8294.5 8349.7 8551.1 8832.8 7699.8 7743.3 7830.5 8380.0 8871.4 07:51:37 INFO - PROCESS | 4385 | -------- Summary: end -------- 07:51:37 INFO - PROCESS | 4385 | 07:51:38 INFO - TEST-INFO | 4385: exit 0 07:51:38 INFO - TEST-OK | dromaeo_css | took 1111982ms 07:51:38 INFO - TEST-START | kraken 07:51:38 INFO - operating with platform_type : linux_ 07:51:38 INFO - Initialising browser for kraken test... 07:51:38 INFO - TEST-INFO | started process 4654 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNU9H4o/profile http://localhost:58955/getInfo.html) 07:51:42 INFO - PROCESS | 4654 | 07:51:42 INFO - PROCESS | 4654 | (process:4723): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:51:42 INFO - PROCESS | 4654 | __metrics Screen width/height:1600/1200 07:51:42 INFO - PROCESS | 4654 | colorDepth:24 07:51:42 INFO - PROCESS | 4654 | Browser inner width/height: 1024/697 07:51:42 INFO - PROCESS | 4654 | __metrics 07:51:43 ERROR - PROCESS | 4654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 07:51:44 INFO - TEST-INFO | 4654: exit 0 07:51:44 INFO - Browser initialized. 07:51:44 INFO - Running cycle 1/1 for kraken test... 07:51:44 INFO - TEST-INFO | started process 4775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNU9H4o/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:46 INFO - PROCESS | 4775 | 07:51:46 INFO - PROCESS | 4775 | (process:4835): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:51:56 INFO - PROCESS | 4775 | RSS: Main: 165863424 07:51:56 INFO - PROCESS | 4775 | 07:51:58 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-beat-detection) 07:51:59 INFO - PROCESS | 4775 | RSS: Main: 168759296 07:51:59 INFO - PROCESS | 4775 | 07:52:01 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-dft) 07:52:02 INFO - PROCESS | 4775 | RSS: Main: 171208704 07:52:02 INFO - PROCESS | 4775 | 07:52:05 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-fft) 07:52:05 INFO - PROCESS | 4775 | RSS: Main: 165507072 07:52:05 INFO - PROCESS | 4775 | 07:52:08 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-oscillator) 07:52:08 INFO - PROCESS | 4775 | RSS: Main: 166727680 07:52:08 INFO - PROCESS | 4775 | 07:52:10 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:11 INFO - PROCESS | 4775 | RSS: Main: 168435712 07:52:11 INFO - PROCESS | 4775 | 07:52:14 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:15 INFO - PROCESS | 4775 | RSS: Main: 168714240 07:52:15 INFO - PROCESS | 4775 | 07:52:18 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:19 INFO - PROCESS | 4775 | RSS: Main: 169230336 07:52:19 INFO - PROCESS | 4775 | 07:52:22 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58955/tests/kraken/driver.html?testName=json-parse-financial) 07:52:22 INFO - PROCESS | 4775 | RSS: Main: 171507712 07:52:22 INFO - PROCESS | 4775 | 07:52:24 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58955/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:24 INFO - PROCESS | 4775 | RSS: Main: 171991040 07:52:24 INFO - PROCESS | 4775 | 07:52:26 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:27 INFO - PROCESS | 4775 | RSS: Main: 171175936 07:52:27 INFO - PROCESS | 4775 | 07:52:29 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:52:30 INFO - PROCESS | 4775 | RSS: Main: 171233280 07:52:30 INFO - PROCESS | 4775 | 07:52:32 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:52:33 INFO - PROCESS | 4775 | RSS: Main: 171888640 07:52:33 INFO - PROCESS | 4775 | 07:52:35 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:52:36 INFO - PROCESS | 4775 | RSS: Main: 171786240 07:52:36 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58955/tests/kraken/driver.html?testName=ai-astar) 07:52:38 INFO - PROCESS | 4775 | RSS: Main: 171655168 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | __start_tp_report 07:52:38 INFO - PROCESS | 4775 | _x_x_mozilla_page_load 07:52:38 INFO - PROCESS | 4775 | _x_x_mozilla_page_load_details 07:52:38 INFO - PROCESS | 4775 | |i|pagename|runs| 07:52:38 INFO - PROCESS | 4775 | |0;ai-astar;111;106;112;111;111;123;111;110;111;110 07:52:38 INFO - PROCESS | 4775 | |1;audio-beat-detection;155;126;156;177;127;153;154;137;178;128 07:52:38 INFO - PROCESS | 4775 | |2;audio-dft;163;163;163;163;163;162;165;163;169;163 07:52:38 INFO - PROCESS | 4775 | |3;audio-fft;75;73;74;75;73;75;73;73;144;76 07:52:38 INFO - PROCESS | 4775 | |4;audio-oscillator;94;94;142;93;99;93;140;94;94;141 07:52:38 INFO - PROCESS | 4775 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;117;118;118 07:52:38 INFO - PROCESS | 4775 | |6;imaging-darkroom;148;146;146;147;148;147;146;147;147;147 07:52:38 INFO - PROCESS | 4775 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;102;96 07:52:38 INFO - PROCESS | 4775 | |8;json-parse-financial;61;61;58;58;59;60;60;58;57;55 07:52:38 INFO - PROCESS | 4775 | |9;json-stringify-tinderbox;68;68;68;70;68;69;68;69;69;68 07:52:38 INFO - PROCESS | 4775 | |10;stanford-crypto-aes;90;82;83;83;84;84;83;84;84;83 07:52:38 INFO - PROCESS | 4775 | |11;stanford-crypto-ccm;117;121;119;128;120;124;130;122;122;116 07:52:38 INFO - PROCESS | 4775 | |12;stanford-crypto-pbkdf2;144;157;151;157;163;141;161;152;155;140 07:52:38 INFO - PROCESS | 4775 | |13;stanford-crypto-sha256-iterative;71;68;72;70;76;68;72;69;70;68 07:52:38 INFO - PROCESS | 4775 | __end_tp_report 07:52:38 INFO - PROCESS | 4775 | __start_cc_report 07:52:38 INFO - PROCESS | 4775 | _x_x_mozilla_cycle_collect,832 07:52:38 INFO - PROCESS | 4775 | __end_cc_report 07:52:38 INFO - PROCESS | 4775 | __startTimestamp1457538758316__endTimestamp 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | ------- Summary: start ------- 07:52:38 INFO - PROCESS | 4775 | Number of tests: 14 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.33 (3.9%) stddev-sans-first:4.58 07:52:38 INFO - PROCESS | 4775 | Values: 111.0 106.0 112.0 111.0 111.0 123.0 111.0 110.0 111.0 110.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:154.50 stddev:19.29 (12.5%) stddev-sans-first:20.34 07:52:38 INFO - PROCESS | 4775 | Values: 155.0 126.0 156.0 177.0 127.0 153.0 154.0 137.0 178.0 128.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.00 (1.2%) stddev-sans-first:2.11 07:52:38 INFO - PROCESS | 4775 | Values: 163.0 163.0 163.0 163.0 163.0 162.0 165.0 163.0 169.0 163.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:22.13 (29.7%) stddev-sans-first:23.36 07:52:38 INFO - PROCESS | 4775 | Values: 75.0 73.0 74.0 75.0 73.0 75.0 73.0 73.0 144.0 76.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:22.56 (24.0%) stddev-sans-first:23.32 07:52:38 INFO - PROCESS | 4775 | Values: 94.0 94.0 142.0 93.0 99.0 93.0 140.0 94.0 94.0 141.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:52:38 INFO - PROCESS | 4775 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 07:52:38 INFO - PROCESS | 4775 | Values: 148.0 146.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.89 (2.0%) stddev-sans-first:1.99 07:52:38 INFO - PROCESS | 4775 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 102.0 96.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.50 stddev:1.89 (3.2%) stddev-sans-first:1.81 07:52:38 INFO - PROCESS | 4775 | Values: 61.0 61.0 58.0 58.0 59.0 60.0 60.0 58.0 57.0 55.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 07:52:38 INFO - PROCESS | 4775 | Values: 68.0 68.0 68.0 70.0 68.0 69.0 68.0 69.0 69.0 68.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.21 (2.6%) stddev-sans-first:0.71 07:52:38 INFO - PROCESS | 4775 | Values: 90.0 82.0 83.0 83.0 84.0 84.0 83.0 84.0 84.0 83.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:122.00 stddev:4.46 (3.7%) stddev-sans-first:4.36 07:52:38 INFO - PROCESS | 4775 | Values: 117.0 121.0 119.0 128.0 120.0 124.0 130.0 122.0 122.0 116.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:156.00 stddev:8.10 (5.2%) stddev-sans-first:8.05 07:52:38 INFO - PROCESS | 4775 | Values: 144.0 157.0 151.0 157.0 163.0 141.0 161.0 152.0 155.0 140.0 07:52:38 INFO - PROCESS | 4775 | 07:52:38 INFO - PROCESS | 4775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.50 (3.6%) stddev-sans-first:2.65 07:52:38 INFO - PROCESS | 4775 | Values: 71.0 68.0 72.0 70.0 76.0 68.0 72.0 69.0 70.0 68.0 07:52:38 INFO - PROCESS | 4775 | -------- Summary: end -------- 07:52:38 INFO - PROCESS | 4775 | 07:52:39 INFO - TEST-INFO | 4775: exit 0 07:52:39 INFO - TEST-OK | kraken | took 60791ms 07:52:39 INFO - SUITE-END | took 1172s 07:52:39 INFO - Completed test suite (00:19:32) 07:52:39 INFO - javascript benchmark 07:52:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3165.509346051362, 3242.7081562659355, 3262.9510557341646, 3268.035929400828, 3275.2958114005482, 5267.710275934832, 5301.7084060376665, 5311.07056265154, 5327.0943939530325, 5339.919901201481, 5147.124988751912, 5316.229146773716, 5347.866303342418, 5402.027635025694, 5431.158170483582, 4873.171560834667, 4882.755862206894, 4919.26211068339, 4986.626003049786, 5080.212567052113, 4892.9510704892855, 4896.534829191221, 4932.8520144395725, 4941.728204948727, 4944.184209605411, 4771.045790841846, 4874.829380971684, 4924.729139897304, 4946.3817022872145, 4967.7019378837385, 4885.047415753929, 4890.413150421972, 4890.926636100461, 4898.21628539432, 4950.455449900508, 4759.714417134983, 4858.684185527929, 4874.610031197496, 4892.681975671606, 4907.656464047518, 5192.6105542084115, 5242.292290540767, 5248.606354523387, 5255.106631872591, 5283.656562323436, 5742.7415766290615, 5770.2210201622665, 5773.682447465388, 5781.82654520365, 5783.0, 5619.971900140514, 5716.971415142939, 5796.391378905197, 5800.303963524362, 5814.709264536798, 5369.3556773187465, 5377.78488860449, 5384.703841288728, 5392.703401312926, 5394.487523685244, 5846.327672317653, 5848.473637372572, 5850.707464626752, 5855.473007429352, 5857.297124345106, 5547.16792481123, 5615.073512870331, 5647.0, 5674.687892165971, 5696.800611978644, 5624.887502249932, 5734.913976290359, 5776.653400795965, 5785.71071446426, 5786.103154011051, 5572.58205634579, 5587.664740115606, 5631.042722737145, 5659.5755318351285, 5674.546036317085, 5472.945270547243, 5651.463111004448, 5699.116636921284, 5711.7144142792695, 5758.74085666146, 4281.571842815693, 4296.914061718748, 4303.677224208197, 4308.267594508941, 4339.826406943687, 3870.2453021661067, 3886.106195575034, 3889.105505733697, 3902.2585708715255, 3932.0, 5312.282841816383, 5367.302250707383, 5432.103702888979, 5453.0, 5512.062949298629, 5714.314282286152, 5725.141228815711, 5733.283339582552, 5743.770249189985, 5764.942350576441, 5420.24116623673, 5428.972855135699, 5438.646487978269, 5451.536619387317, 5456.491788004642, 4772.141014617333, 4821.783019764119, 4846.200376937836, 4848.3697119374965, 4897.314375987294, 5930.229070220844, 5949.0481522956115, 5979.431953964367, 5985.670788106609, 5989.820305390933, 5577.051901176728, 5701.800436984686, 5713.542916566747, 5719.57103217252, 5727.942720572741, 5991.700414979321, 6005.339412664691, 6039.396060394101, 6047.667378294236, 6069.484093852072, 5685.744141513725, 5694.402087780723, 5704.372519022987, 5707.915496055736, 5726.770929162787, 5683.715814209356, 5791.0734282514595, 5797.826065218051, 5798.188253644577, 5809.157672137432, 5533.474319939599, 5561.776409189972, 5580.665160090245, 5646.153077038477, 5686.744096515584, 5428.212909128233, 5528.778848846001, 5536.169574563848, 5549.611527193219, 5551.084071128219, 5427.4301198373605, 5452.781888724565, 5455.0, 5461.9453805461435, 5502.504774570308, 5536.0, 5550.2507161534295, 5579.721013949367, 5579.939811435815, 5586.720663966867, 5443.755031023693, 5487.862803429946, 5488.533474654699, 5490.0941344677685, 5491.862703432446], "unit": "score", "name": "dojo.html", "value": 5279.514330720642}, {"lowerIsBetter": false, "replicates": [534.2360424592831, 544.8202093309208, 563.5547917145457, 582.9941700582998, 604.356360476093, 37458.62541374585, 37597.0, 37796.0, 37810.621893781055, 37897.621023789754, 40750.18499630006, 41346.0, 41458.79270603643, 41638.58361416385, 41642.37536436956, 8565.528895910722, 8711.651533938666, 8734.563271836383, 8748.343874209428, 8755.25580325673, 8794.164554367357, 8929.419587726778, 8951.418157819753, 8966.506842123681, 8973.416727912698, 8874.778130546756, 8929.866052009193, 8945.55272236389, 8976.326775491863, 9017.143371379709, 8870.37907346486, 8935.374523783337, 8954.462732236087, 8954.597043133075, 8962.327825413055, 8857.0, 8952.657101434772, 8960.820783584357, 8966.148215919477, 8987.865182022275, 41513.547025854255, 41806.37290440646, 42004.78997605023, 42015.0, 42102.789486052374, 2800.7339302766204, 3293.176705823544, 3510.3330367230146, 3609.0, 3693.5013773140818, 27523.174304770888, 27669.446611067866, 27963.0, 28283.434331313463, 28381.290467738472, 3814.828332725034, 3835.5013848199833, 3877.0888841122314, 3938.862139825121, 3986.820593073319, 187473.0, 187563.0, 188826.0, 188937.05531472393, 189708.0, 54135.458645413826, 54157.45842541603, 54217.72891135519, 54224.18663720047, 54257.0, 63075.0, 70494.0, 70824.2917570828, 70962.64518677373, 71033.64483177551, 14519.78220326696, 14586.708265834835, 14662.926685366505, 14693.26533673312, 14731.0, 10311.84532232017, 10320.48397580133, 10329.276950613536, 10333.121684656888, 10337.896621033844, 20609.969501524865, 20946.057427415803, 21022.684659730116, 21077.36767896935, 21121.471963201042, 7836.7461206206735, 7988.520688758576, 8035.678572857137, 8035.839283214303, 8177.141400152898, 805.2752522729473, 826.5536610230529, 917.564157025421, 951.8191543606692, 959.822432849925, 27753.722462775113, 28616.570751438747, 29804.40391192164, 29927.251818704706, 31431.52852707211, 981.3081777346953, 1012.7063151686076, 1037.040737317993, 1042.8227201375785, 1078.126717358926, 12366.505339786489, 12886.355682215852, 14107.083039602392, 14345.497907573394, 14403.135811851322, 263834.0, 265648.0, 269466.0, 270247.0, 270363.0, 50359.49640503621, 50370.74814625904, 50838.0, 50991.490085099416, 51052.0, 919.72868003939, 1329.3619062849887, 1336.1181620130862, 1337.2645045225088, 1341.2556031402664, 20673.689894651292, 26152.476950460503, 26204.344891377867, 26425.471490569696, 26444.603330949667, 46696.766516167205, 46751.53248467472, 46774.298385523565, 46800.0, 47220.7638961803, 321106.0, 322524.0, 322567.0, 323627.0, 323631.0, 33141.0, 33850.83074584611, 33885.0, 34082.0, 34117.147071322426, 44210.55789442064, 45703.0, 45706.54293457156, 46704.0, 46852.7657361711, 37463.81268093642, 38886.61113388943, 39599.2080158401, 41224.0, 41314.58685413228, 35697.1075723109, 36869.81565092158, 37054.629453705114, 40799.38800917929, 41094.0, 35863.10342241465, 37531.24937501289, 37549.249015019, 38280.234395312495, 38438.0, 29849.5522567166, 31229.531557027116, 31515.684843151274, 31923.521147183274, 33424.33151336911, 21060.894695526425, 24293.757062429857, 27721.44557108887, 28062.85968570144, 28279.71720282771], "unit": "score", "name": "ext.html", "value": 18212.669393352655}, {"lowerIsBetter": false, "replicates": [348.1835096698243, 356.3283211146989, 366.543653151826, 371.7174947040249, 373.9270842185775, 16245.675086498262, 16576.419825306115, 17358.21888015039, 17369.47891563252, 17372.391966281182, 15095.698086038301, 15130.924345378258, 15197.24013799311, 15223.162726050063, 15462.304196311165, 4549.158405694949, 4767.070421267854, 4797.0, 4800.375951126366, 4824.951750482485, 4756.35789168463, 4760.928586071212, 4794.544518270759, 4812.0375924815, 4815.205491093965, 4774.8090076397075, 4777.5222477752295, 4786.545278198566, 4786.83246086387, 4792.592629626486, 4642.286171063136, 4709.152352576535, 4754.334393184957, 4769.737664428455, 4927.0, 4824.831130910401, 4854.927176092361, 4874.341963834908, 4889.706617602955, 4895.7062576245535, 12806.0, 12857.0, 12934.54729084487, 13004.414801333867, 13017.544385946541, 2061.309461330456, 2083.5520363122, 2106.7471903371693, 2108.5045014421753, 2159.4601349662585, 9076.591553380114, 9248.306377021683, 9286.071392860727, 9499.620015199383, 9584.37701549397, 1765.1527266911953, 1775.7602723632274, 1796.1917137288272, 1843.6773564626137, 1853.5458812590866, 60649.0, 66823.3317666822, 67944.6602766983, 69044.6547767263, 69396.0, 10269.948650256702, 10343.896561034293, 10433.634822781318, 10628.14974802014, 10740.838887416696, 14064.578062658136, 14162.64593385153, 14232.359543820552, 14257.144571325754, 14269.0, 7206.0, 7523.699052037857, 7555.622218889033, 7561.697532098765, 7620.428467864932, 7065.0815393998455, 7134.785956421316, 7204.53170543913, 7263.818404539928, 7291.781246562611, 4427.446569178853, 4428.047969686533, 4455.6212721918355, 4491.348754430589, 4504.797284122223, 1796.6761491241361, 1826.1508398594717, 1834.4221570205343, 1862.394721715448, 1881.7741870975572, 836.5691668790578, 899.4648184330313, 922.6171138977384, 928.4893308680333, 932.4638332958576, 15839.524814255361, 16761.83238167627, 17025.914870425815, 17372.565685857702, 17790.644187116184, 899.4558292233236, 915.3592485260344, 942.4816351006918, 950.6102497975935, 1001.0840081325506, 8613.397062205711, 9493.240540756722, 9508.524573771283, 9661.951690241644, 10240.283180177465, 416828.0, 431415.0, 439230.0, 441668.0, 442938.0, 56688.0, 63451.0, 66878.0, 72455.2754472459, 74423.0, 904.7828521155008, 944.6693657219918, 962.0235461007084, 968.1915600473683, 985.1773768903046, 14384.856151438351, 14699.853001469848, 14763.778543321643, 15238.542843714706, 15856.52430427089, 31984.6801531991, 32769.0, 33468.66531334655, 33698.15754606057, 33761.831190844874, 42378.0, 42439.151216976104, 42472.0, 44473.332900007175, 47132.7643361781, 8078.87881681787, 8150.470219435718, 8370.204830541088, 8371.41400101987, 8502.702405415781, 11507.769844603228, 12607.802258785767, 13349.199048057148, 13359.0, 13361.866381336451, 10014.186515343778, 10506.527206275583, 10877.67366978992, 10933.0, 10942.945285273523, 9794.65718699842, 10235.641752538626, 10521.526531305957, 10602.681919542427, 11118.777624447628, 10223.539940702834, 11508.136889733136, 11629.360385178896, 11783.52865885355, 11839.408029598313, 8151.551664658501, 8161.224683655043, 8167.959160204398, 8170.101288858102, 8179.10029896699, 10231.84652230232, 10608.575656973635, 10736.194785390971, 10908.072813810915, 11515.366654834064], "unit": "score", "name": "jquery.html", "value": 8083.896132268488}, {"lowerIsBetter": false, "replicates": [1435.9353829077693, 1440.4598275646633, 1623.0910690013593, 1788.2846861255505, 1807.602327487953, 7090.539114957524, 7632.580208088553, 7902.091259505151, 8065.91934080659, 8073.152319006501, 7775.805604859881, 7867.291943725064, 7933.801654958615, 7940.047194336687, 7988.121306656263, 2151.860129091608, 2168.718066651333, 2171.5005548723802, 2180.193328468461, 2182.170775105458, 2225.788550087739, 2248.2693124734446, 2280.429892526868, 2284.8286378521593, 2289.244549298736, 2264.6942662740485, 2290.530441259546, 2304.9193278235266, 2311.179531266401, 2321.2688003279, 2203.5703037907615, 2208.3374987503685, 2211.07135003299, 2221.7889300516504, 2230.955380892373, 2280.2247235939694, 2315.1549684365255, 2316.9189078382346, 2317.930462086123, 2329.0683726509365, 8019.518828870287, 8108.472949258338, 8112.945317108797, 8118.675252989873, 8143.104258531557, 4518.186726389248, 4561.270196768501, 4566.703164294344, 4573.748443835588, 4595.402597662316, 2956.024511911064, 2993.266649670823, 3151.952720709191, 3175.952360714591, 3183.1723751824693, 961.846104623264, 965.9565319560567, 985.5269470654126, 991.0, 1006.1598565198068, 11079.944600277107, 11101.0, 11128.221024528286, 11155.944220278929, 11171.497282622302, 4227.7463352198965, 4266.381374700651, 4304.89237769052, 4318.654507639381, 4331.761753103547, 9426.387284826464, 9435.339526233098, 9435.52822358893, 9452.43285402878, 9484.0515948406, 4708.788104535304, 4708.976455117771, 4731.313959475926, 4762.333273341735, 4771.379720636364, 3925.9607403926166, 4217.072244106292, 4229.7250678706405, 4291.957080429156, 4322.697411181187, 3668.761530500509, 3701.3152566775234, 3764.7741135531955, 3792.2036372362113, 3807.667316439224, 1217.2392254840724, 1229.0, 1230.267990545624, 1230.7569354951563, 1233.2970206981934, 1059.6238335390979, 1063.5161001744343, 1232.950681972729, 1344.253939063829, 1345.5626921250437, 7492.887606685904, 7569.697212111564, 7584.317411432998, 7624.390048796083, 7761.8447631047065, 1019.2406657040552, 1062.7980683670078, 1069.5775168808432, 1071.737424331044, 1073.2648136026846, 6177.1969643945995, 6181.412765787333, 6263.279722831932, 6266.530010249249, 6269.247690277196, 9499.952500237454, 10017.749556261151, 10037.297389182833, 10037.397756134655, 10070.244731645156, 9761.170300524393, 9880.555375008142, 9888.752781180385, 9948.104670579683, 9958.601655933826, 7362.374198193106, 7440.888386674204, 7488.5506869588, 7537.095548534211, 7613.6573854176695, 7478.1774004858335, 7581.658825352762, 7606.657700403606, 7621.618919054136, 7622.16156222804, 8298.70954516589, 8561.529115898686, 8586.570671466527, 8619.1811777881, 8694.260987815853, 8564.314854811475, 8761.868571971298, 8821.117888211127, 8875.334349923653, 8922.73231803047, 6081.939180608138, 6740.157480314961, 6938.8612227756175, 6956.165260168812, 7011.4741394394605, 7656.73201437947, 7681.807954801175, 7691.923080769121, 7720.729774457867, 7750.92249077502, 6599.835004124743, 6676.732930682719, 6717.093192418961, 6734.898976515258, 6740.528163028541, 6704.66476676174, 6772.05191273232, 6934.306569343227, 6988.091548098715, 7013.894791578233, 6878.793636190922, 6884.311568843075, 6901.516893817385, 6905.0, 6913.965430172817, 6632.668366581748, 6685.598864068172, 6698.631575263213, 6725.630090345078, 6737.056812046219, 6706.798796036127, 6752.0, 6777.254502004677, 6780.355866192901, 6800.557963732342], "unit": "score", "name": "mootools.html", "value": 4554.857399335819}, {"lowerIsBetter": false, "replicates": [349.4147303267028, 354.89885382665943, 358.3013124407406, 358.68077411104116, 359.207946478016, 6179.227596550426, 6190.473809726173, 6200.720967556459, 6216.968915155424, 6241.0950412190205, 6156.692165391735, 6177.505799536027, 6185.134081228621, 6190.752369905198, 6199.597026193305, 4634.0, 4705.63536574393, 4712.0, 4730.645201609876, 4790.592799612028, 4710.952890471103, 4729.929051064237, 4737.478877323491, 4747.121782470237, 4747.7388743619085, 4675.18184317743, 4711.128441238365, 4729.881752956169, 4740.0, 4740.383750112481, 4727.196376615983, 4732.195526760442, 4734.19518681825, 4751.4535828379485, 4754.809807607691, 4063.248299064653, 4085.387191921206, 4092.0997380576227, 4102.323116685743, 4134.131832315217, 5886.558508111866, 5897.144913987448, 5899.941000589982, 5905.763769449217, 5914.852128696774, 5435.184722291688, 5559.416261292547, 5564.443555644443, 5566.4990150886615, 5609.49514543693, 6430.0, 6454.93545064548, 6558.573692710006, 6587.374199451045, 6605.273419923805, 4676.602488788423, 4706.694064885772, 4715.033418149271, 4718.103560323562, 4730.053989202173, 6812.4550035997, 6831.6242606656615, 6839.965800171017, 6888.621125838077, 6897.827554311132, 4761.333413322138, 4771.355866957916, 4774.116788394158, 4789.137955168103, 4818.7831547580445, 4836.854894353175, 4859.392575928009, 4861.0277944411255, 4872.366592342973, 4875.219964805614, 5281.973590132025, 5412.0, 5422.267993820863, 5430.266913966564, 5586.190002449704, 6477.935220647733, 6501.0573466847045, 6535.411812936859, 6539.574927629784, 6545.887199176152, 1714.9056801876015, 1741.521081702542, 1741.9303227870744, 1743.5466778637644, 1745.0, 1179.1392283632997, 1183.5206741269799, 1189.5360809284387, 1207.806750919866, 1219.1892391559513, 6230.750769969241, 6247.312795592481, 6252.624842509464, 6259.937400626027, 6266.717997690115, 6721.764738234237, 6765.763198288037, 6770.255271920085, 6777.491688123312, 6787.626680532618, 6170.7223174957235, 6273.372662733781, 6302.054691796267, 6367.42693157618, 6382.6170429774365, 3666.505021822073, 3672.8347224374966, 3681.5214022176947, 3681.6870566001653, 3682.650148235913, 7185.89221161683, 7186.856262874818, 7192.82017949545, 7195.532290401107, 7195.676194571257, 7017.824554386181, 7020.087388639547, 7026.754063607749, 7039.436845052383, 7060.92939070613, 7130.750423735144, 7212.4951253411755, 7243.818904527324, 7260.165081015645, 7296.16094149169, 6801.1158549388265, 6818.727250909908, 6823.624700641512, 6829.941359089349, 6833.863322733418, 6738.696758645775, 6750.548632044134, 6750.966245168743, 6760.391564759196, 6766.966165169143, 7237.3486386225495, 7237.769579171448, 7245.420366370572, 7248.528845625017, 7265.309795569412, 4540.818367265272, 4574.473935497461, 4582.633389328779, 4598.517155698737, 4600.585947264763, 6615.239247486601, 6810.693518791567, 6848.657567121524, 6871.553349032297, 6903.827404314731, 6626.966865165836, 6665.466762658879, 6673.432758215606, 6674.532782705164, 6677.899831502628, 6617.239017513048, 6655.733770649314, 6659.866802664016, 6663.300353463011, 6671.933280667326, 6538.8365290868105, 6540.771073012422, 6541.672916354068, 6547.672616369257, 6557.409833115043, 6685.431738302104, 6686.465082793462, 6692.933070669231, 6710.194776626836, 6725.058491811053, 6522.445592124533, 6540.8364790880605, 6541.149650545399, 6550.47596192313, 6561.671916404065], "unit": "score", "name": "prototype.html", "value": 5010.219910285785}, {"lowerIsBetter": false, "replicates": [667.9565828221168, 668.1280928388458, 731.8572878288734, 747.4991755523798, 753.07371932523, 12068.2759034458, 12145.635630931076, 12166.574169904055, 12190.878091219085, 12217.022638188946, 12882.355882205899, 13043.673908152301, 13063.41214645341, 13072.215667059983, 13081.934590327035, 654.5123882707389, 801.8396320735847, 810.7608255564622, 816.6488409983705, 820.6143112737004, 801.6673080671543, 805.814662627596, 808.8948436703221, 811.5333683132193, 814.722994181978, 859.995700021499, 862.7368652560966, 864.3171894203572, 864.5029108262743, 864.8572985457392, 852.5737131434283, 852.8720691896203, 853.2320911179957, 853.5945425922699, 856.8500512410303, 632.1907957814005, 636.4653690899667, 636.700750647195, 638.1385130074409, 639.0669622351372, 12981.41583628739, 13105.082644214908, 13107.672308192372, 13157.342132893316, 13403.932980335134, 12699.301538415384, 12820.743585128339, 12860.485580576858, 12912.0, 13034.543790967366, 10143.797124057477, 10248.391351264972, 10465.9476702616, 10516.0, 10551.84172237417, 3606.296772129436, 3711.0722319420147, 3712.2204337089242, 3733.7386382953205, 3746.3631182699005, 48195.277070843964, 48284.0, 48287.0, 48505.51494485081, 48541.0, 9540.236781057498, 10067.949660251652, 10082.445465499468, 10384.221183411275, 10388.0, 16966.660666786844, 17103.828961710224, 17106.657866842594, 17115.74326385105, 17129.143542823058, 7331.633418329062, 7424.591647459333, 7573.318401343906, 7588.506747061423, 7592.81017974555, 4232.30167022444, 4245.235857545671, 4296.61330480252, 4408.4269045024585, 4444.799984000728, 3172.428962786674, 3197.0249074032645, 3200.6159260888376, 3215.887443939451, 3219.2917558137174, 531.7607076815449, 543.0659266062366, 544.6868050870766, 551.3383939272888, 554.1659801997968, 602.7769725201616, 625.1966223402906, 626.7273735924887, 648.4779752299349, 649.2339039932924, 8178.83642327162, 8294.917050829536, 8455.069942306342, 8472.618732157067, 9386.389884657476, 469.11571687369553, 475.7121941225509, 487.0599742496944, 622.1041699952145, 681.5706105153721, 3997.960020399759, 4123.0, 4274.038341373166, 4460.375547423363, 4510.72935623857, 51799.0, 54270.0, 54769.904601907736, 54817.451825481236, 58251.4174858246, 48789.756051220225, 48794.268085978736, 48856.26715599269, 48871.0, 49678.25482617764, 46525.767371162925, 46762.766186168854, 46848.0, 46877.531224688, 46997.53002470068, 7823.804404889924, 8647.56762161902, 8840.469571825453, 8869.201771840308, 8881.42270752399, 32415.837920810245, 33212.83393583017, 33258.50112248366, 33345.83327083349, 34002.489962651074, 38681.6131838678, 38739.22521549497, 38797.03007424724, 39022.41466378063, 39047.0, 4358.210557389313, 10682.8397574038, 10744.623938162127, 11006.339619622848, 11334.773304534028, 8868.33487488428, 11322.094232461548, 11334.433278335886, 11378.829317560077, 11483.25358851672, 9900.603975840886, 10439.060484556427, 10699.985575512033, 10924.399158046384, 11161.49773260189, 10522.842157367493, 10528.210384221062, 10657.360558366523, 10967.561297548009, 11102.666919992413, 9553.283503737108, 9657.130858222794, 9697.0, 9959.850602240827, 10020.148287395654, 8088.636011379384, 8294.460860044319, 8349.749507514784, 8551.10213427606, 8832.823343533222, 7699.846003080019, 7743.264389882952, 7830.4518683691595, 8380.0, 8871.423357481743], "unit": "score", "name": "yui.html", "value": 6058.492355011538}], "name": "dromaeo_css", "value": 6895.302833580796}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 111.0, 111.0, 123.0, 111.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 156.0, 177.0, 127.0, 153.0, 154.0, 137.0, 178.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 163.0, 163.0, 162.0, 165.0, 163.0, 169.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 75.0, 73.0, 75.0, 73.0, 73.0, 144.0, 76.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 93.0, 99.0, 93.0, 140.0, 94.0, 94.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 102.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 58.0, 58.0, 59.0, 60.0, 60.0, 58.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 70.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [90.0, 82.0, 83.0, 83.0, 84.0, 84.0, 83.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 119.0, 128.0, 120.0, 124.0, 130.0, 122.0, 122.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [144.0, 157.0, 151.0, 157.0, 163.0, 141.0, 161.0, 152.0, 155.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 72.0, 70.0, 76.0, 68.0, 72.0, 69.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1530.5}]} 07:52:39 INFO - Return code: 0 07:52:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:52:39 ERROR - # TBPL SUCCESS # 07:52:39 INFO - Running post-action listener: _resource_record_post_action 07:52:39 INFO - Running post-run listener: _resource_record_post_run 07:52:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2535424; Write bytes: 537038848; Read time: 1484; Write time: 483924 07:52:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241164288; Read time: 0; Write time: 286000 07:52:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 2535424; Write bytes: 295874560; Read time: 1484; Write time: 197924 07:52:40 INFO - Running post-run listener: _upload_blobber_files 07:52:40 INFO - Blob upload gear active. 07:52:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:52:40 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 07:52:40 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:52:40 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:52:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:52:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:52:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:52:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:41 INFO - (blobuploader) - INFO - Done attempting. 07:52:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:52:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:42 INFO - (blobuploader) - INFO - Done attempting. 07:52:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:52:42 INFO - Return code: 0 07:52:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:52:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:52:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c468715379fa6252214a33b26754d7332fd2f712cdba3a511b846c2acad840e7557062807e1226fa200c96f5256e8314f751fee4c2c4c81b734b9411f40d3110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47adfa2efd6e9ae9907442faec4f16542b3e18a5563588060e4408cf3e846afc7310f213e11431e10180dda23a7e5780be7b8cda6ac95e3d267c60186c9fb883"} 07:52:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:52:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:52:42 INFO - Contents: 07:52:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c468715379fa6252214a33b26754d7332fd2f712cdba3a511b846c2acad840e7557062807e1226fa200c96f5256e8314f751fee4c2c4c81b734b9411f40d3110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47adfa2efd6e9ae9907442faec4f16542b3e18a5563588060e4408cf3e846afc7310f213e11431e10180dda23a7e5780be7b8cda6ac95e3d267c60186c9fb883"} 07:52:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:52:42 INFO - Copying logs to upload dir... 07:52:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:52:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.753354 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-09 07:52:42.076427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 07:52:42.080132) ========= 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c468715379fa6252214a33b26754d7332fd2f712cdba3a511b846c2acad840e7557062807e1226fa200c96f5256e8314f751fee4c2c4c81b734b9411f40d3110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47adfa2efd6e9ae9907442faec4f16542b3e18a5563588060e4408cf3e846afc7310f213e11431e10180dda23a7e5780be7b8cda6ac95e3d267c60186c9fb883"} build_url:https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/COgO0Us-ROuO9UYEXaJ8bQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c468715379fa6252214a33b26754d7332fd2f712cdba3a511b846c2acad840e7557062807e1226fa200c96f5256e8314f751fee4c2c4c81b734b9411f40d3110", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47adfa2efd6e9ae9907442faec4f16542b3e18a5563588060e4408cf3e846afc7310f213e11431e10180dda23a7e5780be7b8cda6ac95e3d267c60186c9fb883"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 07:52:42.109217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:52:42.109938) ========= 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=523ca41ca1e0623de333ad52000001bf-1457537471.848170-2021526060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 07:52:42.192909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 07:52:42.193238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 07:52:42.193561) ========= ========= Total master_lag: 6.81 =========