builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1459129991.41 results: success (0) buildid: 20160327163001 builduid: 0162a7b6902e455c85590799618a5f96 revision: db4111c66699e246fd9fdf7d562526297a11c7df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.406256) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.406747) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.407036) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006469 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.461024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.461326) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.553159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.553439) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.603443) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.603738) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.604086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.604352) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-27 18:53:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.0M=0s 2016-03-27 18:53:12 (97.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145568 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.762602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.762925) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017941 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.822700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.822999) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev db4111c66699e246fd9fdf7d562526297a11c7df --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 db4111c66699e246fd9fdf7d562526297a11c7df --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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-27 18:53:12,665 truncating revision to first 12 chars 2016-03-27 18:53:12,665 Setting DEBUG logging. 2016-03-27 18:53:12,665 attempt 1/10 2016-03-27 18:53:12,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/db4111c66699?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-27 18:53:12,901 unpacking tar archive at: mozilla-inbound-db4111c66699/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.372113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.372412) ========= echo db4111c66699e246fd9fdf7d562526297a11c7df in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'db4111c66699e246fd9fdf7d562526297a11c7df'] 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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False db4111c66699e246fd9fdf7d562526297a11c7df program finished with exit code 0 elapsedTime=0.003437 script_repo_revision: 'db4111c66699e246fd9fdf7d562526297a11c7df' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.419881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.420150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.430205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-27 18:53:12.430479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:53:13 INFO - MultiFileLogger online at 20160327 18:53:13 in /builds/slave/test-pgo 18:53:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:53:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:53:13 INFO - {'append_to_log': False, 18:53:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:53:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:53:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:53:13 INFO - 'branch': 'Mozilla-Inbound', 18:53:13 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:13 INFO - 'config_files': ('talos/linux_config.py',), 18:53:13 INFO - 'default_actions': ('clobber', 18:53:13 INFO - 'read-buildbot-config', 18:53:13 INFO - 'download-and-extract', 18:53:13 INFO - 'populate-webroot', 18:53:13 INFO - 'create-virtualenv', 18:53:13 INFO - 'install', 18:53:13 INFO - 'run-tests'), 18:53:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:13 INFO - 'download_minidump_stackwalk': True, 18:53:13 INFO - 'download_symbols': 'ondemand', 18:53:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:13 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:13 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:13 INFO - 'installer_path': 'installer.exe', 18:53:13 INFO - 'log_level': 'info', 18:53:13 INFO - 'log_name': 'talos', 18:53:13 INFO - 'log_to_console': True, 18:53:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:53:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:53:13 INFO - 'opt_config_files': (), 18:53:13 INFO - 'pip_index': False, 18:53:13 INFO - 'sps_profile': False, 18:53:13 INFO - 'sps_profile_interval': 0, 18:53:13 INFO - 'suite': 'dromaeojs', 18:53:13 INFO - 'system_bits': '32', 18:53:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:13 INFO - 'title': 'talos-linux64-ix-066', 18:53:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:13 INFO - 'use_talos_json': True, 18:53:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:53:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:13 INFO - 'work_dir': 'build'} 18:53:13 INFO - ##### 18:53:13 INFO - ##### Running clobber step. 18:53:13 INFO - ##### 18:53:13 INFO - Running pre-action listener: _resource_record_pre_action 18:53:13 INFO - Running main action method: clobber 18:53:13 INFO - rmtree: /builds/slave/test-pgo/build 18:53:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:53:14 INFO - Running post-action listener: _resource_record_post_action 18:53:14 INFO - ##### 18:53:14 INFO - ##### Running read-buildbot-config step. 18:53:14 INFO - ##### 18:53:14 INFO - Running pre-action listener: _resource_record_pre_action 18:53:14 INFO - Running main action method: read_buildbot_config 18:53:14 INFO - Using buildbot properties: 18:53:14 INFO - { 18:53:14 INFO - "project": "", 18:53:14 INFO - "product": "firefox", 18:53:14 INFO - "script_repo_revision": "production", 18:53:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:53:14 INFO - "repository": "", 18:53:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:53:14 INFO - "buildid": "20160327163001", 18:53:14 INFO - "pgo_build": "True", 18:53:14 INFO - "basedir": "/builds/slave/test-pgo", 18:53:14 INFO - "buildnumber": 1647, 18:53:14 INFO - "slavename": "talos-linux64-ix-066", 18:53:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:53:14 INFO - "platform": "ubuntu64_hw", 18:53:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:53:14 INFO - "branch": "mozilla-inbound", 18:53:14 INFO - "repo_path": "integration/mozilla-inbound", 18:53:14 INFO - "revision": "db4111c66699e246fd9fdf7d562526297a11c7df", 18:53:14 INFO - "stage_platform": "linux64-pgo", 18:53:14 INFO - "builduid": "0162a7b6902e455c85590799618a5f96", 18:53:14 INFO - "slavebuilddir": "test" 18:53:14 INFO - } 18:53:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:53:14 INFO - Running post-action listener: _resource_record_post_action 18:53:14 INFO - ##### 18:53:14 INFO - ##### Running download-and-extract step. 18:53:14 INFO - ##### 18:53:14 INFO - Running pre-action listener: _resource_record_pre_action 18:53:14 INFO - Running main action method: download_and_extract 18:53:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:14 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:53:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:17 INFO - Downloaded 1361 bytes. 18:53:17 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:17 INFO - Using the following test package requirements: 18:53:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:53:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:53:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'jsshell-linux-x86_64.zip'], 18:53:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:53:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:53:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:53:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:53:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:53:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:53: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')]} 18:53:17 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:25 INFO - Downloaded 23655425 bytes. 18:53:25 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'] 18:53:25 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 18:53:26 INFO - Return code: 0 18:53:26 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 18:53:26 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')]} 18:53:26 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:36 INFO - Downloaded 23655425 bytes. 18:53:36 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'] 18:53:36 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 18:53:37 INFO - Return code: 0 18:53:37 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')]} 18:53:37 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:39 INFO - Downloaded 10847531 bytes. 18:53:39 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'] 18:53:39 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 18:53:39 INFO - Return code: 0 18:53: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')]} 18:53:39 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:41 INFO - Downloaded 57747535 bytes. 18:53:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:41 INFO - mkdir: /builds/slave/test-pgo/properties 18:53:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:53:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:53:41 INFO - Contents: 18:53:41 INFO - build_url:https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:42 INFO - Running post-action listener: _resource_record_post_action 18:53:42 INFO - Running post-action listener: set_extra_try_arguments 18:53:42 INFO - ##### 18:53:42 INFO - ##### Running populate-webroot step. 18:53:42 INFO - ##### 18:53:42 INFO - Running pre-action listener: _resource_record_pre_action 18:53:42 INFO - Running main action method: populate_webroot 18:53:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:42 INFO - '--tppagecycles', 18:53:42 INFO - '7'], 18:53:42 INFO - 'tests': ['tsvgm']}}, 18:53:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:53:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:53:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:53:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'tests': ['damp', 'tps']}, 18:53:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['damp', 'tps']}, 18:53:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:53:42 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['dromaeo_dom']}, 18:53:42 INFO - 'other': {'tests': ['a11yr', 18:53:42 INFO - 'ts_paint', 18:53:42 INFO - 'tpaint', 18:53:42 INFO - 'sessionrestore', 18:53:42 INFO - 'sessionrestore_no_auto_restore', 18:53:42 INFO - 'tabpaint']}, 18:53:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['a11yr', 18:53:42 INFO - 'ts_paint', 18:53:42 INFO - 'tpaint', 18:53:42 INFO - 'sessionrestore', 18:53:42 INFO - 'sessionrestore_no_auto_restore', 18:53:42 INFO - 'tabpaint']}, 18:53:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['a11yr', 18:53:42 INFO - 'ts_paint', 18:53:42 INFO - 'tpaint', 18:53:42 INFO - 'sessionrestore', 18:53:42 INFO - 'sessionrestore_no_auto_restore', 18:53:42 INFO - 'tabpaint']}, 18:53:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['a11yr', 18:53:42 INFO - 'ts_paint', 18:53:42 INFO - 'tpaint', 18:53:42 INFO - 'sessionrestore', 18:53:42 INFO - 'sessionrestore_no_auto_restore', 18:53:42 INFO - 'tabpaint']}, 18:53:42 INFO - 'other_l64': {'tests': ['a11yr', 18:53:42 INFO - 'ts_paint', 18:53:42 INFO - 'tpaint', 18:53:42 INFO - 'sessionrestore', 18:53:42 INFO - 'sessionrestore_no_auto_restore', 18:53:42 INFO - 'tabpaint']}, 18:53:42 INFO - 'other_nol64': {'tests': ['a11yr', 18:53:42 INFO - 'ts_paint', 18:53:42 INFO - 'tpaint', 18:53:42 INFO - 'sessionrestore', 18:53:42 INFO - 'sessionrestore_no_auto_restore', 18:53:42 INFO - 'tabpaint']}, 18:53:42 INFO - 'svgr': {'tests': ['tsvgx', 18:53:42 INFO - 'tsvgr_opacity', 18:53:42 INFO - 'tart', 18:53:42 INFO - 'tscrollx', 18:53:42 INFO - 'cart']}, 18:53:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['tsvgx', 18:53:42 INFO - 'tsvgr_opacity', 18:53:42 INFO - 'tart', 18:53:42 INFO - 'tscrollx', 18:53:42 INFO - 'cart']}, 18:53:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'tests': ['tp5o']}, 18:53:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'talos_options': ['--e10s'], 18:53:42 INFO - 'tests': ['tp5o']}, 18:53:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'talos_options': ['--xperf_path', 18:53:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:42 INFO - 'tests': ['tp5n']}, 18:53:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:42 INFO - 'talos_options': ['--e10s', 18:53:42 INFO - '--xperf_path', 18:53:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:42 INFO - 'tests': ['tp5n']}}, 18:53:42 INFO - 'talos.zip': {'path': '', 18:53:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:42 INFO - Running post-action listener: _resource_record_post_action 18:53:42 INFO - ##### 18:53:42 INFO - ##### Running create-virtualenv step. 18:53:42 INFO - ##### 18:53:42 INFO - Running pre-action listener: _resource_record_pre_action 18:53:42 INFO - Running main action method: create_virtualenv 18:53:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:53:42 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 18:53:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:53:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:42 INFO - Using real prefix '/usr' 18:53:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:53:43 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:45 INFO - Installing pip.................done. 18:53:45 INFO - Return code: 0 18:53:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:53: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:53: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 pip>=1.5 18:53:45 INFO - Using env: {'DISPLAY': ':0', 18:53:45 INFO - 'HOME': '/home/cltbld', 18:53:45 INFO - 'LANG': 'en_US.UTF-8', 18:53:45 INFO - 'LANGUAGE': 'en_US:en', 18:53:45 INFO - 'LOGNAME': 'cltbld', 18:53:45 INFO - 'MAIL': '/var/mail/cltbld', 18:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:45 INFO - 'MOZ_NO_REMOTE': '1', 18:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:45 INFO - 'NO_EM_RESTART': '1', 18:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:45 INFO - 'SHELL': '/bin/bash', 18:53:45 INFO - 'SHLVL': '1', 18:53:45 INFO - 'TERM': 'linux', 18:53:45 INFO - 'TMOUT': '86400', 18:53:45 INFO - 'USER': 'cltbld', 18:53:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:45 INFO - '_': '/tools/buildbot/bin/python'} 18:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:45 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 18:53:45 INFO - Cleaning up... 18:53:45 INFO - Return code: 0 18:53:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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', '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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:53: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:53: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 psutil>=0.7.1 18:53:45 INFO - Using env: {'DISPLAY': ':0', 18:53:45 INFO - 'HOME': '/home/cltbld', 18:53:45 INFO - 'LANG': 'en_US.UTF-8', 18:53:45 INFO - 'LANGUAGE': 'en_US:en', 18:53:45 INFO - 'LOGNAME': 'cltbld', 18:53:45 INFO - 'MAIL': '/var/mail/cltbld', 18:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:45 INFO - 'MOZ_NO_REMOTE': '1', 18:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:45 INFO - 'NO_EM_RESTART': '1', 18:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:45 INFO - 'SHELL': '/bin/bash', 18:53:45 INFO - 'SHLVL': '1', 18:53:45 INFO - 'TERM': 'linux', 18:53:45 INFO - 'TMOUT': '86400', 18:53:45 INFO - 'USER': 'cltbld', 18:53:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:45 INFO - '_': '/tools/buildbot/bin/python'} 18:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:45 INFO - Downloading/unpacking psutil>=0.7.1 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:47 INFO - Installing collected packages: psutil 18:53:47 INFO - Running setup.py install for psutil 18:53:47 INFO - building 'psutil._psutil_linux' extension 18:53:47 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 18:53:47 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 18:53:47 INFO - building 'psutil._psutil_posix' extension 18:53:47 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 18:53:48 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 18:53:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:48 INFO - Successfully installed psutil 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:53:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:53:50 INFO - Installing collected packages: mozsystemmonitor 18:53:50 INFO - Running setup.py install for mozsystemmonitor 18:53:50 INFO - Successfully installed mozsystemmonitor 18:53:50 INFO - Cleaning up... 18:53:50 INFO - Return code: 0 18:53:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:53:50 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')]} 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:50 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')]} 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:50 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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:53:50 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 18:53:50 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 18:53:50 INFO - Using env: {'DISPLAY': ':0', 18:53:50 INFO - 'HOME': '/home/cltbld', 18:53:50 INFO - 'LANG': 'en_US.UTF-8', 18:53:50 INFO - 'LANGUAGE': 'en_US:en', 18:53:50 INFO - 'LOGNAME': 'cltbld', 18:53:50 INFO - 'MAIL': '/var/mail/cltbld', 18:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:50 INFO - 'MOZ_NO_REMOTE': '1', 18:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:50 INFO - 'NO_EM_RESTART': '1', 18:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:50 INFO - 'SHELL': '/bin/bash', 18:53:50 INFO - 'SHLVL': '1', 18:53:50 INFO - 'TERM': 'linux', 18:53:50 INFO - 'TMOUT': '86400', 18:53:50 INFO - 'USER': 'cltbld', 18:53:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:50 INFO - '_': '/tools/buildbot/bin/python'} 18:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:50 INFO - Downloading/unpacking blobuploader==1.2.4 18:53:50 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 18:53:50 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 18:53:50 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 18:53:50 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 18:53:50 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 18:53:50 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 18:53:52 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:53:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:53 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 18:53:53 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 18:53:53 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 18:53:53 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 18:53:53 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 18:53:53 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 18:53:53 INFO - Downloading docopt-0.6.1.tar.gz 18:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:53 INFO - Running setup.py install for blobuploader 18:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:53:53 INFO - Running setup.py install for requests 18:53:53 INFO - Running setup.py install for docopt 18:53:53 INFO - Successfully installed blobuploader requests docopt 18:53:53 INFO - Cleaning up... 18:53:53 INFO - Return code: 0 18:53:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:53 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')]} 18:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:53 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')]} 18:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:53 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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:53:53 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 18:53:53 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 18:53:53 INFO - Using env: {'DISPLAY': ':0', 18:53:53 INFO - 'HOME': '/home/cltbld', 18:53:53 INFO - 'LANG': 'en_US.UTF-8', 18:53:53 INFO - 'LANGUAGE': 'en_US:en', 18:53:53 INFO - 'LOGNAME': 'cltbld', 18:53:53 INFO - 'MAIL': '/var/mail/cltbld', 18:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:53 INFO - 'MOZ_NO_REMOTE': '1', 18:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:53 INFO - 'NO_EM_RESTART': '1', 18:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:53 INFO - 'SHELL': '/bin/bash', 18:53:53 INFO - 'SHLVL': '1', 18:53:53 INFO - 'TERM': 'linux', 18:53:53 INFO - 'TMOUT': '86400', 18:53:53 INFO - 'USER': 'cltbld', 18:53:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:53 INFO - '_': '/tools/buildbot/bin/python'} 18:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:54 INFO - Running setup.py (path:/tmp/pip-_6976z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:54 INFO - Running setup.py (path:/tmp/pip-5c_oxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:54 INFO - Running setup.py (path:/tmp/pip-7FDgBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:54 INFO - Running setup.py (path:/tmp/pip-9ohyNm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:54 INFO - Running setup.py (path:/tmp/pip-VTbi1D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:54 INFO - Running setup.py (path:/tmp/pip-gc5lP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:54 INFO - Running setup.py (path:/tmp/pip-OxzCzv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:54 INFO - Running setup.py (path:/tmp/pip-qbQ45W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:54 INFO - Running setup.py (path:/tmp/pip-jwT3nP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:54 INFO - Running setup.py (path:/tmp/pip-7Kr24R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:54 INFO - Running setup.py (path:/tmp/pip-iue9GO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:54 INFO - Running setup.py (path:/tmp/pip-dfYHUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:55 INFO - Running setup.py (path:/tmp/pip-CidcoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:55 INFO - Running setup.py (path:/tmp/pip-9ZueHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:55 INFO - Running setup.py (path:/tmp/pip-P11Bls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:55 INFO - Running setup.py (path:/tmp/pip-Y0I3Bv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:55 INFO - Running setup.py (path:/tmp/pip-ZkDjA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:55 INFO - Running setup.py install for manifestparser 18:53:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Running setup.py install for mozcrash 18:53:55 INFO - Running setup.py install for mozdebug 18:53:55 INFO - Running setup.py install for mozdevice 18:53:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:53:55 INFO - Running setup.py install for mozfile 18:53:55 INFO - Running setup.py install for mozhttpd 18:53:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Running setup.py install for mozinfo 18:53:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Running setup.py install for mozInstall 18:53:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Running setup.py install for mozleak 18:53:56 INFO - Running setup.py install for mozlog 18:53:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Running setup.py install for moznetwork 18:53:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Running setup.py install for mozprocess 18:53:56 INFO - Running setup.py install for mozprofile 18:53:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Running setup.py install for mozrunner 18:53:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:53:56 INFO - Running setup.py install for mozscreenshot 18:53:56 INFO - Running setup.py install for moztest 18:53:57 INFO - Running setup.py install for mozversion 18:53:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:53:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:53:57 INFO - Cleaning up... 18:53:57 INFO - Return code: 0 18:53:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:57 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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:53:57 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 18:53:57 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 18:53:57 INFO - Using env: {'DISPLAY': ':0', 18:53:57 INFO - 'HOME': '/home/cltbld', 18:53:57 INFO - 'LANG': 'en_US.UTF-8', 18:53:57 INFO - 'LANGUAGE': 'en_US:en', 18:53:57 INFO - 'LOGNAME': 'cltbld', 18:53:57 INFO - 'MAIL': '/var/mail/cltbld', 18:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:57 INFO - 'MOZ_NO_REMOTE': '1', 18:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:57 INFO - 'NO_EM_RESTART': '1', 18:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:57 INFO - 'SHELL': '/bin/bash', 18:53:57 INFO - 'SHLVL': '1', 18:53:57 INFO - 'TERM': 'linux', 18:53:57 INFO - 'TMOUT': '86400', 18:53:57 INFO - 'USER': 'cltbld', 18:53:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:57 INFO - '_': '/tools/buildbot/bin/python'} 18:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:57 INFO - Running setup.py (path:/tmp/pip-KnvhbQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:57 INFO - Running setup.py (path:/tmp/pip-zK3RlY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:57 INFO - Running setup.py (path:/tmp/pip-NTdaz9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:57 INFO - Running setup.py (path:/tmp/pip-TgGevQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:57 INFO - Running setup.py (path:/tmp/pip-sNuMER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:57 INFO - Running setup.py (path:/tmp/pip-AqZ0Aw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:57 INFO - Running setup.py (path:/tmp/pip-fIAzxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:57 INFO - Running setup.py (path:/tmp/pip-zfTj86-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:57 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)) 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:57 INFO - Running setup.py (path:/tmp/pip-bgnDPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:58 INFO - Running setup.py (path:/tmp/pip-B4OjXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:58 INFO - Running setup.py (path:/tmp/pip-eR5p8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:58 INFO - Running setup.py (path:/tmp/pip-9GoOEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:58 INFO - Running setup.py (path:/tmp/pip-HTtIMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:58 INFO - Running setup.py (path:/tmp/pip-lF4uik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:58 INFO - Running setup.py (path:/tmp/pip-dWce7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:58 INFO - Running setup.py (path:/tmp/pip-2o9XR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:58 INFO - Running setup.py (path:/tmp/pip-oUw1Xq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:58 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)) 18:53:58 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)) 18:53:58 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)) 18:53:58 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)) 18:53:58 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)) 18:53:58 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)) 18:53:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:58 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 18:53:58 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 18:53:58 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 18:53:58 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 18:53:58 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 18:53:58 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 18:54:00 INFO - Downloading blessings-1.6.tar.gz 18:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:54:00 INFO - Installing collected packages: blessings 18:54:00 INFO - Running setup.py install for blessings 18:54:00 INFO - Successfully installed blessings 18:54:00 INFO - Cleaning up... 18:54:00 INFO - Return code: 0 18:54:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:54:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:54:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:54:00 INFO - Reading from file tmpfile_stdout 18:54:00 INFO - Current package versions: 18:54:00 INFO - argparse == 1.2.1 18:54:00 INFO - blessings == 1.6 18:54:00 INFO - blobuploader == 1.2.4 18:54:00 INFO - docopt == 0.6.1 18:54:00 INFO - manifestparser == 1.1 18:54:00 INFO - mozInstall == 1.12 18:54:00 INFO - mozcrash == 0.17 18:54:00 INFO - mozdebug == 0.1 18:54:00 INFO - mozdevice == 0.48 18:54:00 INFO - mozfile == 1.2 18:54:00 INFO - mozhttpd == 0.7 18:54:00 INFO - mozinfo == 0.9 18:54:00 INFO - mozleak == 0.1 18:54:00 INFO - mozlog == 3.1 18:54:00 INFO - moznetwork == 0.27 18:54:00 INFO - mozprocess == 0.22 18:54:00 INFO - mozprofile == 0.28 18:54:00 INFO - mozrunner == 6.11 18:54:00 INFO - mozscreenshot == 0.1 18:54:00 INFO - mozsystemmonitor == 0.0 18:54:00 INFO - moztest == 0.7 18:54:00 INFO - mozversion == 1.4 18:54:00 INFO - psutil == 3.1.1 18:54:00 INFO - requests == 1.2.3 18:54:00 INFO - wsgiref == 0.1.2 18:54:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:00 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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:54:00 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 18:54:00 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 18:54:00 INFO - Using env: {'DISPLAY': ':0', 18:54:00 INFO - 'HOME': '/home/cltbld', 18:54:00 INFO - 'LANG': 'en_US.UTF-8', 18:54:00 INFO - 'LANGUAGE': 'en_US:en', 18:54:00 INFO - 'LOGNAME': 'cltbld', 18:54:00 INFO - 'MAIL': '/var/mail/cltbld', 18:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:00 INFO - 'MOZ_NO_REMOTE': '1', 18:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:00 INFO - 'NO_EM_RESTART': '1', 18:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:00 INFO - 'SHELL': '/bin/bash', 18:54:00 INFO - 'SHLVL': '1', 18:54:00 INFO - 'TERM': 'linux', 18:54:00 INFO - 'TMOUT': '86400', 18:54:00 INFO - 'USER': 'cltbld', 18:54:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:00 INFO - '_': '/tools/buildbot/bin/python'} 18:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 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)) 18:54:01 INFO - Cleaning up... 18:54:01 INFO - Return code: 0 18:54:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:54:01 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 18:54:01 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 18:54:01 INFO - Using env: {'DISPLAY': ':0', 18:54:01 INFO - 'HOME': '/home/cltbld', 18:54:01 INFO - 'LANG': 'en_US.UTF-8', 18:54:01 INFO - 'LANGUAGE': 'en_US:en', 18:54:01 INFO - 'LOGNAME': 'cltbld', 18:54:01 INFO - 'MAIL': '/var/mail/cltbld', 18:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:01 INFO - 'MOZ_NO_REMOTE': '1', 18:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:01 INFO - 'NO_EM_RESTART': '1', 18:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:01 INFO - 'SHELL': '/bin/bash', 18:54:01 INFO - 'SHLVL': '1', 18:54:01 INFO - 'TERM': 'linux', 18:54:01 INFO - 'TMOUT': '86400', 18:54:01 INFO - 'USER': 'cltbld', 18:54:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:01 INFO - '_': '/tools/buildbot/bin/python'} 18:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:01 INFO - Downloading/unpacking jsonschema 18:54:01 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 18:54:01 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 18:54:01 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 18:54:01 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 18:54:01 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 18:54:01 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 18:54:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:54:03 INFO - Downloading/unpacking functools32 (from jsonschema) 18:54:03 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 18:54:03 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 18:54:03 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 18:54:03 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 18:54:03 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 18:54:03 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 18:54:03 INFO - Downloading functools32-3.2.3-2.tar.gz 18:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:54:03 INFO - warning: no files found matching '*.txt' 18:54:03 INFO - no previously-included directories found matching 'build' 18:54:03 INFO - no previously-included directories found matching 'dist' 18:54:03 INFO - no previously-included directories found matching '.git*' 18:54:03 INFO - Installing collected packages: jsonschema, functools32 18:54:03 INFO - Running setup.py install for functools32 18:54:03 INFO - warning: no files found matching '*.txt' 18:54:03 INFO - no previously-included directories found matching 'build' 18:54:03 INFO - no previously-included directories found matching 'dist' 18:54:03 INFO - no previously-included directories found matching '.git*' 18:54:03 INFO - Successfully installed jsonschema functools32 18:54:03 INFO - Cleaning up... 18:54:03 INFO - Return code: 0 18:54:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:03 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 0x7fd8f17cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', '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 18:54:03 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 18:54:03 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 18:54:03 INFO - Using env: {'DISPLAY': ':0', 18:54:03 INFO - 'HOME': '/home/cltbld', 18:54:03 INFO - 'LANG': 'en_US.UTF-8', 18:54:03 INFO - 'LANGUAGE': 'en_US:en', 18:54:03 INFO - 'LOGNAME': 'cltbld', 18:54:03 INFO - 'MAIL': '/var/mail/cltbld', 18:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:03 INFO - 'MOZ_NO_REMOTE': '1', 18:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:03 INFO - 'NO_EM_RESTART': '1', 18:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:03 INFO - 'SHELL': '/bin/bash', 18:54:03 INFO - 'SHLVL': '1', 18:54:03 INFO - 'TERM': 'linux', 18:54:03 INFO - 'TMOUT': '86400', 18:54:03 INFO - 'USER': 'cltbld', 18:54:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:03 INFO - '_': '/tools/buildbot/bin/python'} 18:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:03 INFO - Downloading/unpacking flake8 18:54:03 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 18:54:03 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 18:54:03 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 18:54:03 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 18:54:03 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 18:54:03 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 18:54:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:54:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:54:05 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 18:54:05 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 18:54:05 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 18:54:05 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 18:54:05 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 18:54:05 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 18:54:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:54:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:54:05 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 18:54:05 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 18:54:05 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 18:54:05 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 18:54:05 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 18:54:05 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 18:54:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:54:06 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 18:54:06 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 18:54:06 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 18:54:06 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 18:54:06 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 18:54:06 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 18:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:06 INFO - no previously-included directories found matching 'docs/_build' 18:54:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:54:06 INFO - Running setup.py install for pep8 18:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:06 INFO - no previously-included directories found matching 'docs/_build' 18:54:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:54:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:54:06 INFO - Cleaning up... 18:54:06 INFO - Return code: 0 18:54:06 INFO - Running post-action listener: _resource_record_post_action 18:54:06 INFO - Running post-action listener: _start_resource_monitoring 18:54:06 INFO - Starting resource monitoring. 18:54:06 INFO - ##### 18:54:06 INFO - ##### Running install step. 18:54:06 INFO - ##### 18:54:06 INFO - Running pre-action listener: _resource_record_pre_action 18:54:06 INFO - Running main action method: install 18:54:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:54:06 INFO - Reading from file tmpfile_stdout 18:54:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:54:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:54:07 INFO - Reading from file tmpfile_stdout 18:54:07 INFO - Output received: 18:54:07 INFO - Usage: mozinstall [options] installer 18:54:07 INFO - Options: 18:54:07 INFO - -h, --help show this help message and exit 18:54:07 INFO - -d DEST, --destination=DEST 18:54:07 INFO - Directory to install application into. [default: 18:54:07 INFO - "/builds/slave/test-pgo"] 18:54:07 INFO - --app=APP Application being installed. [default: firefox] 18:54:07 INFO - mkdir: /builds/slave/test-pgo/build/application 18:54:07 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'] 18:54:07 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 18:54:23 INFO - Reading from file tmpfile_stdout 18:54:23 INFO - Output received: 18:54:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:54:23 INFO - Running post-action listener: _resource_record_post_action 18:54:23 INFO - ##### 18:54:23 INFO - ##### Running run-tests step. 18:54:23 INFO - ##### 18:54:23 INFO - Running pre-action listener: _resource_record_pre_action 18:54:23 INFO - Running main action method: run_tests 18:54:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:54:23 INFO - Python 2.7.3 18:54:23 INFO - Return code: 0 18:54:23 INFO - grabbing minidump binary from tooltool 18:54:23 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')]} 18:54:23 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 0x1ee98b0>, '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 0x1eea7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eeac60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:54:23 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 18:54:23 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 18:54:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:23 INFO - Return code: 0 18:54:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:54:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:54:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:54:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:54:24 INFO - Return code: 0 18:54:24 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 18:54:24 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 18:54:24 INFO - Using env: {'DISPLAY': ':0', 18:54:24 INFO - 'HOME': '/home/cltbld', 18:54:24 INFO - 'LANG': 'en_US.UTF-8', 18:54:24 INFO - 'LANGUAGE': 'en_US:en', 18:54:24 INFO - 'LOGNAME': 'cltbld', 18:54:24 INFO - 'MAIL': '/var/mail/cltbld', 18:54:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:24 INFO - 'MOZ_NO_REMOTE': '1', 18:54:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:24 INFO - 'NO_EM_RESTART': '1', 18:54:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:24 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:54:24 INFO - 'SHELL': '/bin/bash', 18:54:24 INFO - 'SHLVL': '1', 18:54:24 INFO - 'TERM': 'linux', 18:54:24 INFO - 'TMOUT': '86400', 18:54:24 INFO - 'USER': 'cltbld', 18:54:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064', 18:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:24 INFO - '_': '/tools/buildbot/bin/python'} 18:54:24 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:54:24 INFO - mozversion application_buildid: 20160327163001 18:54:24 INFO - mozversion application_changeset: db4111c66699e246fd9fdf7d562526297a11c7df 18:54:24 INFO - mozversion application_display_name: Nightly 18:54:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:24 INFO - mozversion application_name: Firefox 18:54:24 INFO - mozversion application_remotingname: firefox 18:54:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:54:24 INFO - mozversion application_vendor: Mozilla 18:54:24 INFO - mozversion application_version: 48.0a1 18:54:24 INFO - mozversion platform_buildid: 20160327163001 18:54:24 INFO - mozversion platform_changeset: db4111c66699e246fd9fdf7d562526297a11c7df 18:54:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:54:24 INFO - mozversion platform_version: 48.0a1 18:54:24 INFO - using testdate: 1459130064 18:54:24 INFO - actual date: 1459130064 18:54:24 INFO - starting webserver on 'localhost:33745' 18:54:24 INFO - SUITE-START | Running 2 tests 18:54:24 INFO - TEST-START | dromaeo_css 18:54:24 INFO - operating with platform_type : linux_ 18:54:24 INFO - Initialising browser for dromaeo_css test... 18:54:24 INFO - TEST-INFO | started process 30999 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMRd7xB/profile http://localhost:33745/getInfo.html) 18:54:29 INFO - PROCESS | 30999 | __metrics Screen width/height:1600/1200 18:54:29 INFO - PROCESS | 30999 | colorDepth:24 18:54:29 INFO - PROCESS | 30999 | Browser inner width/height: 1024/697 18:54:29 INFO - PROCESS | 30999 | __metrics 18:54:30 ERROR - PROCESS | 30999 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:54:30 INFO - TEST-INFO | 30999: exit 0 18:54:30 INFO - Browser initialized. 18:54:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:30 INFO - TEST-INFO | started process 31095 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMRd7xB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:42 INFO - PROCESS | 31095 | RSS: Main: 153399296 18:54:42 INFO - PROCESS | 31095 | 18:55:33 INFO - PROCESS | 31095 | 1459130133437 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] 18:57:40 INFO - PROCESS | 31095 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33745/tests/dromaeo/cssquery-ext.html) 18:57:41 INFO - PROCESS | 31095 | RSS: Main: 253054976 18:57:41 INFO - PROCESS | 31095 | 19:00:44 INFO - PROCESS | 31095 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-ext.html (next: http://localhost:33745/tests/dromaeo/cssquery-jquery.html) 19:00:44 INFO - PROCESS | 31095 | RSS: Main: 236183552 19:00:44 INFO - PROCESS | 31095 | 19:03:46 INFO - PROCESS | 31095 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33745/tests/dromaeo/cssquery-mootools.html) 19:03:47 INFO - PROCESS | 31095 | RSS: Main: 227999744 19:03:47 INFO - PROCESS | 31095 | 19:06:49 INFO - PROCESS | 31095 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33745/tests/dromaeo/cssquery-prototype.html) 19:06:49 INFO - PROCESS | 31095 | RSS: Main: 203177984 19:06:49 INFO - PROCESS | 31095 | 19:09:52 INFO - PROCESS | 31095 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33745/tests/dromaeo/cssquery-yui.html) 19:09:52 INFO - PROCESS | 31095 | RSS: Main: 218996736 19:09:52 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | Cycle 1(1): loaded http://localhost:33745/tests/dromaeo/cssquery-yui.html (next: http://localhost:33745/tests/dromaeo/cssquery-dojo.html) 19:12:55 INFO - PROCESS | 31095 | RSS: Main: 264011776 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | __start_tp_report 19:12:55 INFO - PROCESS | 31095 | _x_x_mozilla_page_load 19:12:55 INFO - PROCESS | 31095 | _x_x_mozilla_page_load_details 19:12:55 INFO - PROCESS | 31095 | |i|pagename|runs| 19:12:55 INFO - PROCESS | 31095 | |0;dojo.html;3055.511118221085;3087.1973286945386;3112.4708799504083;3124.0940127363065;3155.132338606883;5087.923681144785;5218.843434696955;5232.47675232477;5268.420473747885;5278.049951008817;5280.5247527722495;5286.31277933868;5290.55030322423;5334.546563542103;5356.38401583818;4721.457032441279;4756.667033307661;4825.25208592667;4873.098476781789;4918.434380046305;4793.113274044313;4831.734254615994;4875.341828853113;4878.438979517366;4879.829205977774;4618.699784514012;4725.574698277154;4771.880702982418;4785;4816.4220293564995;4790.305405716152;4807.879803004953;4820.566149046603;4828.661993660445;4854.902901941977;4675.766211689436;4755.643326750507;4777.928331075037;4790.449098353664;4847.151748444044;5111.821086262;5127.743612819381;5131.153359695646;5144.871378215537;5160.432352441228;5553.333599967989;5554.972225138848;5557.360903496109;5560.610757246995;5561.332640083176;5389.973050134763;5574.721263936827;5595.440455954413;5602.38373778888;5636.464535869086;5257.369115706101;5272.499112584298;5276.657017293902;5296.92054619181;5318.388385335697;5704.515116215168;5708.429157084258;5711.143328500675;5711.600187986801;5717.914231286534;5335.1730481775385;5399.5950303726595;5447.727613619303;5485.040117979338;5492.450754924475;5567.359753628303;5570.888582228333;5571;5572.777088916398;5575.052241118939;5548.805791797267;5550.91673624896;5552.861178470571;5553.750081246354;5600.5799565032785;5431.782728690808;5466.508014278655;5511.972440137773;5536.861578460571;5560.582956278296;4252.170826688828;4266.552012038754;4270.572942705705;4271.188474189894;4302.763348015889;3714.5728241252064;3840.0975770693863;3846.1730727893078;3867.303885300673;3893.649571538575;5235.633505654568;5266.131088370453;5271.288376069258;5302.787888484495;5315.760790764425;5550.056490396642;5594.524465420403;5598.440155984369;5606.747696353674;5607;5137.51193636604;5282.788688452496;5295.629305948623;5298.0463516566615;5349.86625334362;4856.757162141878;4858.368412106474;4874.634402419832;4888.340074090023;4922.680025798311;5798.623089499169;5804.738786754606;5815.709214539341;5822.155787410802;5866.354700982888;5392.892142157057;5590.832275031756;5631.662100273997;5631.943680563224;5664.943350566442;5736.053551164178;5752.33848107473;5757.165211044291;5757.280339957505;5808.186853840551;5489.313835770528;5489.423610520837;5491.615586908878;5496.367917689357;5507.972460137674;5420.539254163283;5591.049521581423;5636.098224284095;5735.168400581809;5752.194692742935;5432.619716619799;5438.809641662523;5442.9455705444025;5443.891122177455;5506.311711036121;5395.055865223649;5397.541208997279;5407.270018547603;5413.945860541344;5450.400455949763;5186.792528298825;5349.1976203569775;5420.701861397503;5490.752916118704;5498.202760599771;5502.202180683858;5525.336959564878;5529.502344788988;5534.86162845916;5538.418466061005;5406.432324605859;5427.213054107054;5428.972855135699;5430.83707488776;5432.619716619799 19:12:55 INFO - PROCESS | 31095 | |1;ext.html;506.53398873036826;535.6545028456648;560.3611882454002;582.9446202610752;596.6062398816782;30200.84899575502;39695.40456893149;40083.79958100209;40115.598844011554;40169.59830401695;45259.773701131446;46085;46238.30642540364;46272.30591541129;46285.768571157096;7810.882836757425;8801.163889430525;9006.549672516348;9006.819863602725;9996.600135994588;10084.14284785794;10690.78618427631;10711.732206694816;10718.249722519427;10721.624743133953;10734.570617175343;10834.40410777407;10837.729056773565;10838.72903177419;10841.457927103653;10649.78700425991;10748.785024299548;10753.193510486706;10755.569777208902;10757.462126893624;10481.213908956859;10629.468526573717;10640.467976601216;10643.042126208678;10645.680629581047;42720;42914.356284655754;43109.13781724379;43221.78389108034;43272.13455730899;3121.9219519511967;3157.7947433416984;3163.604549431321;3375.2236985493473;3737.9626203738158;32667.346653067045;32704.83647581747;32949.341013179845;32995.505067424005;33329;4275.7862106894845;4306.741595504249;4337.587929146726;4374.781260936972;4391.251169861397;326999;328081;328655;329638;329930;61646.691766540884;62124.37875621276;62288.688556556925;62319.376806231354;62518;69910.3008969914;70814.29185708077;70842.64578677074;70870;70903;15829.762553561706;15993.760093598605;16010.27953742061;16010.9199454002;16017.19914004295;11939.46272417726;12035.638930832089;12096.274223546616;12099;12117.515299388102;21102.577948440947;21243.256486022914;21255.256066037615;21337.78662213358;22141.225057122923;7386.584140188813;7697.615119244016;7875.684972601031;7931.365490760841;7936;1002.1281485108003;1023.7747695507126;1036.1917704190744;1042.4370839746603;1082.9025387714985;28662.713372866423;29159.562606560918;29551.85224073866;29948.550771738443;30252.54621180684;1033.395463653756;1109.4951796932376;1143.17691262291;1229.2992993993516;1249.8875101240933;15852.76220856688;16426.507204783877;16535;16615.41846035383;16921.576960576083;379631.9165637553;383517;384143;384384;384749;54327.18509222365;54426.18360724593;54986;55035.17447238295;55082.72458637681;1117.9552817887193;1357.457017193111;1362.087401441037;1386.3622733542684;1393.6306878677158;29127;31499.370012600077;33305.83347083249;35091.473627895095;35094.82452587721;50717;50882.49117508777;50966.49033509766;51530.48469515257;51565;284522;287157;287861;288110;288408;41844.3723344144;42269.36595951002;42857;43173;43199.56800432081;49634.255486167014;49894.501054988985;50033.749831250614;50603.746981264856;51344.48655513397;41762.1647567053;42468.78765606152;43058.35412468878;43135;44019.55980440283;41967.370489443296;42549.78725106355;42622.78688606537;43325.78337108294;43410.131797364505;37227.44158837565;37655.81172094122;38051.80974095112;42233;43878;27602.861985690746;35199;35398.64601353953;35852.10369740777;35866.4620030705;27239.319017024733;27372.863135684194;27414.629268536894;27535.44929101447;27674.86162569174 19:12:55 INFO - PROCESS | 31095 | |2;jquery.html;355.19016642056107;358.23338056558987;363.72720459655267;376.3601876809425;376.9528808898888;17585.824141758578;17794.28822847086;18680.81319186811;18696.626067478643;18699.158537865795;15090.39638414465;17444.38944636938;17446.82553174468;17456.389026384048;17460.214290356933;4762.9285560716535;5028;5031.22016087507;5037.143685573443;5037.722925239111;3884.6698030667285;4910.558049775519;5382.165764306539;5611.80358687446;5630.774769009235;5601.719914004283;5605.915911261334;5616.6068375213545;5620.831375058734;5625.212470254168;5575.609707320489;5892.351841297454;5910.290765108171;6099.115628233925;6119.051547010221;5353.197020446964;5377.704226267554;5381.784728610851;5382.219578161144;5382.842688821883;13662.93168534161;20737.688934665992;20940.476488087766;20954.057067432;21003.369898903056;2284.680144779732;2288.588054150269;2313.5372925414986;2317.2237300504353;2317.617593097137;9517.476538790364;9555.904440955572;9759.463229522373;9848.606055757833;9996.100350968447;1904.7904730479636;1957.0606109067585;1973.8797835866737;1974.8716333438424;2029.6448121578665;70458.29541704568;71113.64443177803;71149;71796.64101679511;73003.26996730018;10029.348092373972;10079.64721234768;10177.745556361151;10236.283460157718;10246.129079028366;13774;14018.929905350407;14019.158850469004;14034.157950522796;14070;7494.426170504146;7585.1656317805;7629.771106866803;7643.541387516767;7701.499402538817;7481.401487880957;7519.248075192547;7563.584002879785;7586.393088552903;7587.393008559302;4181.26827805139;4265.936010959838;4266.679999000087;4325.351197320364;4342.457192850894;1662.8337166283518;1734.9306027759;1770.663573920951;1776.200709680649;1829.8627602929832;1019.2763138171832;1024.109025148126;1057.2916146181922;1061.5063995242094;1079.7138758229075;16918.492445226664;18164.1826117825;18212.180451879696;18393.17230724594;18780.624387512446;1006.9093781559695;1008.7578981044496;1036.124474818777;1043.6816770884802;1065.3661071662348;9382.530873456437;10311.793764124675;10405.687829365132;10409.635662751767;10455.84316235257;489457;494662;501334;543468;550032;82014.58992704998;86124;86422.56788716016;86678;87505;1027.9588816447258;1042.2391654092555;1045.8065257927308;1050.5010120192846;1052.3317693264833;15604.531864044096;15654.608634784221;15853.682926341178;15856.920715396349;16027.439039634024;35612.28775424425;35705.64294357023;36113.63886361103;37655.435168471944;38704.6129538701;49131;50765.746171268904;51914.22128668149;53081.73459132679;53634.46365536451;7836.882446763189;8097.676092956216;8193.627622290265;8194.262516373556;8197.426180167331;9405.576749046173;12970.481180753042;13506;13645.863541364857;13717.588472345846;9380.624775008922;11404;11448.656540303804;11462.484188211718;11539.480723367637;5507.697076660822;10253.10317591248;10561.155107591221;11601;11960.162788604714;11710.590129345432;12040.879591203975;12053.216540924812;12295;12358.567450139562;8133.430659853753;8178.5092894426525;8264.297534709616;8365.24712775853;8417.158284171779;11159.27464714791;11410.14423918193;11485.253458525169;11549;11999.460024298753 19:12:55 INFO - PROCESS | 31095 | |3;mootools.html;1168.1705988747988;1300.089937044069;1334.7330533893223;1411.470698488067;1623.4155703946585;6982.720691172353;7084.468664850131;7107.999999999994;7111.324424179701;7115.501914865961;7122.608256545888;7214.242504537026;7218.639068046603;7230.349268565828;7249.673764680589;1929.170456703617;1963.1460314763053;2193.934181974543;2256.875871827053;2281.931542053741;2227.120287486442;2232.687423760675;2238.104758096758;2241.0251540579898;2243.1139699818564;2205.933821985335;2220.522587643656;2227.9108835646553;2307.7576854430295;2312.9653055204185;2235.0501037059184;2268.5236100418933;2269.1604106480545;2271.82961277904;2272.8181745460406;2269.8751568663715;2283.075354481421;2285.954280914389;2286.416963674252;2289.9656505152434;7041.683124259421;7107;7129.144502659662;7133.928660713378;7137.464690148259;4642.071585682843;4704.153252414564;4711.128441238382;4739.73931433771;4739.881502962419;3164.114048066545;3168.825714585697;3296.868125274986;3314.386838434897;3321.2693207494312;1089.9455027248605;1106.6016234155697;1118.949647265875;1179.9233049851732;1187.7980743273665;10441.791164176673;10446.16430685551;10450.268481206318;10464.52909619069;10467.319624224401;4166.437530933345;4220.78896055196;4242.172776308652;4307.913841723211;4320.805563749639;8985.775355616162;9023.233025192932;9027.638894444148;9038.457692538468;9049.457032578066;4841.878953026132;4848.17581011229;4851.369321988119;4868.683535570177;4874.683145595525;3835.712321575893;4299.871003869889;4408.493023302297;4438.090191510732;4490.887727806831;3620.7827530348263;3682.1531047859144;3707.8134996801305;3728.4034554471154;3806.71449641278;1207.4687137659403;1212.0667086343642;1215.5684731920219;1215.7446936143333;1238.1704258146883;1056.3503445381036;1058.4496062047847;1059.4120263253967;1207.782599132147;1343.4827591377195;7335.156457007406;7338.816529586697;7354.411647068222;7354.521956072945;7387.963060184772;1138.322697994692;1151.343734071588;1162.7441962768178;1168.7954607943575;1180.474688763492;5705.942940570624;5726.255586773693;5729.971350143306;5732.885342293131;5749.511291540182;8765.693200737944;8935.910640893508;9043.954780226057;9070.773230669287;9094.909050909539;8768.298536117096;8897.510636914902;8923.598438070303;8933.196012358789;8968.596413161424;6621.139251897319;6908;6915.619640919697;6959.826004349932;6963.234044255128;7199.604021778852;7249.710011599477;7266.055412796302;7285.271472852673;7367.314974523691;8324.875126873223;8472.618732156945;8480.957595211985;8499.660013599387;8550.187732165434;8441.366897482836;8718.215360617574;8729.170728780755;8812.91187088121;8828.646854125764;6081.543884208613;6731;6809.5233333666165;6845.897311540431;6959.130108736408;7252.238514955854;7290.526115802456;7307.561546307238;7322.011528443805;7330.303621155982;6351.9047214290895;6490.383413575702;6505.31694172124;6545.738170473128;6567.44176744982;6207.534434917309;6236.594621349598;6248.468880145057;6387.361263873576;6399.424051835357;6800.557963732539;6837.829054273683;6851.588904665736;6876.656167191721;6883.242843287134;6059.272887253558;6119.663418512025;6164.845878852885;6181.227346581677;6189.690515474118;6295.590786599039;6324.747010119544;6325.209348831396;6341.714622842075;6354.491640668828 19:12:55 INFO - PROCESS | 31095 | |4;prototype.html;327.4662300450266;334.862706290421;337.1587888218894;339.114910084679;346.7815276375881;6003.489703375213;6020.8795824083545;6064.272287325527;6085.878282434349;6092.421219984094;5972.581919265654;5986.521078313735;5991;6003.189569408129;6020.909686354708;4424.225760491917;4531.139083574127;4580.038191979688;4605.746683932382;4627.028324051953;4594.310853371988;4616.33063205835;4619.191641462748;4619.607333376667;4623.74569398683;4581.335706322581;4584.243599806045;4628.467726211478;4628.629709623222;4643.721376717408;4420.97789511052;4493.752843593601;4559.521250268707;4562.270036794131;4568.200564901163;4035.273650742865;4038.9394159087637;4052.7770972596495;4053.5541090480024;4061.801768478306;5743.770249190027;5807.361190269067;5812.709364531756;5820.330661973885;5822.359540450547;5333.973330133324;5336.4930331618825;5339.866503337409;5346.385165705955;5349.652272602269;6307.211598550181;6308.432241098323;6314.557980941336;6315.652639104847;6316.989281714904;4288.270993931008;4357.520672725997;4372.038151606674;4393.978030109861;4483.237849565582;6563.803085907431;6577.6053436793945;6613.173353330833;6628.072069910217;6629.701663425158;4502.527234640381;4504.189245935763;4505.144022635689;4506.639468842484;4508.368828364031;4552;4560.042391097906;4564.178447879413;4565;4576.977115114403;5285.524302812765;5296.1261391870685;5299.44355842631;5301.628885977944;5303.4696530346655;6263.154474146023;6411.711472983727;6418.422341989243;6426.518011149183;6452.483801295885;1556.9844301557066;1566.1229711361673;1569.3722510995692;1569.50560573419;1572.3317590024194;980.8822941246954;1039.9064084232455;1043.139409986764;1045.8483519889726;1062.0494657281845;6055.5458340623745;6106.908396374058;6140.478059364915;6185.474234690012;6192.628442293477;6532.902006469907;6537.280899101095;6539.934600654028;6546.149000629983;6548.246951600627;6149.0776383542825;6192.969035154795;6196.783112591038;6197.96901015492;6204.193454850931;3494.807785571818;3524.083738228028;3524.665156810099;3526.347625689256;3530.435130379127;6544.378284063102;6663.633500157441;6716.093327400836;6720.092787473628;6754.662266886734;6557.8360540985905;6578.703958321887;6601.6699165041555;6605;6622.801315960529;6683.030960510699;6722.1261236039;6725.966370168216;6739.460843132636;6747.527673062838;6517.152770139852;6519.641419721961;6522.21733391996;6524.184476940382;6529.9020514691365;6263.467605253604;6356.141920840812;6399.6800159992745;6403.679816009274;6457.61254324742;6718.462522998051;6729.798106056826;6730.427913627396;6734.629595372302;6740.056392105012;4489.281714925727;4492.415985921809;4516.458025036885;4525.298578720303;4526.728396296233;6502.219733631994;6504.512161587994;6507.219133703986;6514.967425162844;6518.837029074311;6347;6348.143000694847;6348.523860710373;6351.650659213788;6352.809415717536;6277.74889004453;6477.870442591027;6477.935220647733;6489.059086432535;6495.025746137928;6308.747650094128;6352.714127864349;6370.299267080525;6389;6405.071264666691;6554.80335589933;6562.737490500326;6562.8359291018105;6565.573237739532;6569.704363303758;6085;6220.626762394271;6402.775902843378;6448.838779030561;6474.870502590016 19:12:55 INFO - PROCESS | 31095 | |5;yui.html;650.4341223135873;655.672163918041;682.8361193313606;684.3191024930195;695.8712638161941;13223.140495867774;13303.733925321489;13360.53238136663;13378.598642040743;13390;11712.004479619243;11734;11771.823422648667;11841.348725820098;12051.276923384603;513.9563137133348;801.6152246921496;812.4921923797626;829.9543525106117;836.45630340279;824.3775949158377;825.5665775467868;825.7770401991459;830.4436027861317;831.0941074229089;861.4228466927174;864.1833467373335;869.5130726792985;869.5999840073574;869.604330029835;696.5368030259871;856.3149480415674;869.8434281829236;870.6430363550977;871.6600525794945;635.9491240700733;636.1443858010967;636.5830381100386;636.7134789344814;636.812140418573;12271.38643067843;12329.445174967148;12342.074344424114;12346.382680865921;12349.876501235052;12562.434690438951;12791.680207994781;12892.097553171281;13301.800472992913;13410.329483525784;10111.292209545334;10175.440350780704;10224.437655928921;10352.896471035268;10479.58081676732;3610.4584312353095;3659.963400365989;3660.8352624131976;3698.8335524901177;3794.4877441545314;51992.99999999962;52146;52193;52275;52414.7379263105;9769.267304952014;10040.79918401628;10092.798144037079;10237.590496380062;10333.328333658288;19939.302124425576;19955.20179192845;20035.499112522302;20040.498987525138;20060.69908951367;7716.189800071024;7809.140994490602;7811.648475818602;7815.25755053269;8087.474314169678;4575.679702420865;4648.953510464852;4761.857144285607;4800.567948884617;4842.225243960949;3363.9663603364143;3430.433978393537;3438.5529881115795;3438.638942910958;3446.2590543033366;571.7427157779016;572.2646399376781;581.137011537866;581.6742624130416;586.2320360327899;667.5594107888867;682.2330164873002;682.4028974647184;691.975780847678;708.19619731605;9295.58169882357;9682.9031709682;9759.560819762986;9832.950835245778;9844.3601165924;563.467523190581;596.6360520082746;691.9861602767917;703.1983538765811;739.3567596191241;4246.808893599796;4354.455693038371;4411.602955733999;4530.77346132692;4648.581627653527;65855.34144658588;67074;67204.6639766798;67296;67338.32661673418;58214.417855821746;58872;59523;59588.404115958285;59796.402035979954;50861.745691272044;51545.7422712884;51612.48387516152;51710.22434663483;53066.99999999923;8663.783405414915;8744.387892847439;8768.342374321825;8911.777205569653;9019.188273055457;40027.79986100051;40055;40584.59415405808;40611.18777624372;41227;46855.53144468512;47078.87974563285;48077.75961120172;48190;52744.47255527549;11098.5560577576;11416.344630028765;11516.424178791194;11804.993151164152;11976.16166868311;12744.6813829655;12943.676408089497;13008;13085.738285234433;13115.475380984653;11367.658970230907;12469.937650312053;12543.12198146121;12654.936725316315;12907;12254.816177757519;12603.432845521791;12759.362031898554;12792.976561875214;12805.743885122432;11130.443477826238;11135;11726.70683232926;11895.583654572049;11906.166568340479;10200.030997055268;10212.540435680263;10298.330608510423;10335.483225838829;10384.065434110664;10080.647177348757;10082.69751907444;10351.896481035094;10401.68794936153;10411.739706507398 19:12:55 INFO - PROCESS | 31095 | __end_tp_report 19:12:55 INFO - PROCESS | 31095 | __start_cc_report 19:12:55 INFO - PROCESS | 31095 | _x_x_mozilla_cycle_collect,831 19:12:55 INFO - PROCESS | 31095 | __end_cc_report 19:12:55 INFO - PROCESS | 31095 | __startTimestamp1459131175263__endTimestamp 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | ------- Summary: start ------- 19:12:55 INFO - PROCESS | 31095 | Number of tests: 6 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | [#0] dojo.html Cycles:165 Average:5199.20 Median:5399.60 stddev:569.67 (10.6%) stddev-sans-first:546.03 19:12:55 INFO - PROCESS | 31095 | Values: 3055.5 3087.2 3112.5 3124.1 3155.1 5087.9 5218.8 5232.5 5268.4 5278.0 5280.5 5286.3 5290.6 5334.5 5356.4 4721.5 4756.7 4825.3 4873.1 4918.4 4793.1 4831.7 4875.3 4878.4 4879.8 4618.7 4725.6 4771.9 4785.0 4816.4 4790.3 4807.9 4820.6 4828.7 4854.9 4675.8 4755.6 4777.9 4790.4 4847.2 5111.8 5127.7 5131.2 5144.9 5160.4 5553.3 5555.0 5557.4 5560.6 5561.3 5390.0 5574.7 5595.4 5602.4 5636.5 5257.4 5272.5 5276.7 5296.9 5318.4 5704.5 5708.4 5711.1 5711.6 5717.9 5335.2 5399.6 5447.7 5485.0 5492.5 5567.4 5570.9 5571.0 5572.8 5575.1 5548.8 5550.9 5552.9 5553.8 5600.6 5431.8 5466.5 5512.0 5536.9 5560.6 4252.2 4266.6 4270.6 4271.2 4302.8 3714.6 3840.1 3846.2 3867.3 3893.6 5235.6 5266.1 5271.3 5302.8 5315.8 5550.1 5594.5 5598.4 5606.7 5607.0 5137.5 5282.8 5295.6 5298.0 5349.9 4856.8 4858.4 4874.6 4888.3 4922.7 5798.6 5804.7 5815.7 5822.2 5866.4 5392.9 5590.8 5631.7 5631.9 5664.9 5736.1 5752.3 5757.2 5757.3 5808.2 5489.3 5489.4 5491.6 5496.4 5508.0 5420.5 5591.0 5636.1 5735.2 5752.2 5432.6 5438.8 5442.9 5443.9 5506.3 5395.1 5397.5 5407.3 5413.9 5450.4 5186.8 5349.2 5420.7 5490.8 5498.2 5502.2 5525.3 5529.5 5534.9 5538.4 5406.4 5427.2 5429.0 5430.8 5432.6 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | [#1] ext.html Cycles:180 Average:52145.81 Median:35146.91 stddev:87767.97 (249.7%) stddev-sans-first:87928.54 19:12:55 INFO - PROCESS | 31095 | Values: 506.5 535.7 560.4 582.9 596.6 30200.8 39695.4 40083.8 40115.6 40169.6 45259.8 46085.0 46238.3 46272.3 46285.8 7810.9 8801.2 9006.5 9006.8 9996.6 10084.1 10690.8 10711.7 10718.2 10721.6 10734.6 10834.4 10837.7 10838.7 10841.5 10649.8 10748.8 10753.2 10755.6 10757.5 10481.2 10629.5 10640.5 10643.0 10645.7 42720.0 42914.4 43109.1 43221.8 43272.1 3121.9 3157.8 3163.6 3375.2 3738.0 32667.3 32704.8 32949.3 32995.5 33329.0 4275.8 4306.7 4337.6 4374.8 4391.3 326999.0 328081.0 328655.0 329638.0 329930.0 61646.7 62124.4 62288.7 62319.4 62518.0 69910.3 70814.3 70842.6 70870.0 70903.0 15829.8 15993.8 16010.3 16010.9 16017.2 11939.5 12035.6 12096.3 12099.0 12117.5 21102.6 21243.3 21255.3 21337.8 22141.2 7386.6 7697.6 7875.7 7931.4 7936.0 1002.1 1023.8 1036.2 1042.4 1082.9 28662.7 29159.6 29551.9 29948.6 30252.5 1033.4 1109.5 1143.2 1229.3 1249.9 15852.8 16426.5 16535.0 16615.4 16921.6 379631.9 383517.0 384143.0 384384.0 384749.0 54327.2 54426.2 54986.0 55035.2 55082.7 1118.0 1357.5 1362.1 1386.4 1393.6 29127.0 31499.4 33305.8 35091.5 35094.8 50717.0 50882.5 50966.5 51530.5 51565.0 284522.0 287157.0 287861.0 288110.0 288408.0 41844.4 42269.4 42857.0 43173.0 43199.6 49634.3 49894.5 50033.7 50603.7 51344.5 41762.2 42468.8 43058.4 43135.0 44019.6 41967.4 42549.8 42622.8 43325.8 43410.1 37227.4 37655.8 38051.8 42233.0 43878.0 27602.9 35199.0 35398.6 35852.1 35866.5 27239.3 27372.9 27414.6 27535.4 27674.9 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | [#2] jquery.html Cycles:180 Average:28438.40 Median:1336.40 stddev:84771.56 (6343.3%) stddev-sans-first:84983.14 19:12:55 INFO - PROCESS | 31095 | Values: 355.2 358.2 363.7 376.4 377.0 17585.8 17794.3 18680.8 18696.6 18699.2 15090.4 17444.4 17446.8 17456.4 17460.2 4762.9 5028.0 5031.2 5037.1 5037.7 3884.7 4910.6 5382.2 5611.8 5630.8 5601.7 5605.9 5616.6 5620.8 5625.2 5575.6 5892.4 5910.3 6099.1 6119.1 5353.2 5377.7 5381.8 5382.2 5382.8 13662.9 20737.7 20940.5 20954.1 21003.4 2284.7 2288.6 2313.5 2317.2 2317.6 9517.5 9555.9 9759.5 9848.6 9996.1 1904.8 1957.1 1973.9 1974.9 2029.6 70458.3 71113.6 71149.0 71796.6 73003.3 10029.3 10079.6 10177.7 10236.3 10246.1 13774.0 14018.9 14019.2 14034.2 14070.0 7494.4 7585.2 7629.8 7643.5 7701.5 7481.4 7519.2 7563.6 7586.4 7587.4 4181.3 4265.9 4266.7 4325.4 4342.5 1662.8 1734.9 1770.7 1776.2 1829.9 1019.3 1024.1 1057.3 1061.5 1079.7 16918.5 18164.2 18212.2 18393.2 18780.6 1006.9 1008.8 1036.1 1043.7 1065.4 9382.5 10311.8 10405.7 10409.6 10455.8 489457.0 494662.0 501334.0 543468.0 550032.0 82014.6 86124.0 86422.6 86678.0 87505.0 1028.0 1042.2 1045.8 1050.5 1052.3 15604.5 15654.6 15853.7 15856.9 16027.4 35612.3 35705.6 36113.6 37655.4 38704.6 49131.0 50765.7 51914.2 53081.7 53634.5 7836.9 8097.7 8193.6 8194.3 8197.4 9405.6 12970.5 13506.0 13645.9 13717.6 9380.6 11404.0 11448.7 11462.5 11539.5 5507.7 10253.1 10561.2 11601.0 11960.2 11710.6 12040.9 12053.2 12295.0 12358.6 8133.4 8178.5 8264.3 8365.2 8417.2 11159.3 11410.1 11485.3 11549.0 11999.5 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | [#3] mootools.html Cycles:180 Average:5319.92 Median:6070.41 stddev:2708.01 (44.6%) stddev-sans-first:2697.61 19:12:55 INFO - PROCESS | 31095 | Values: 1168.2 1300.1 1334.7 1411.5 1623.4 6982.7 7084.5 7108.0 7111.3 7115.5 7122.6 7214.2 7218.6 7230.3 7249.7 1929.2 1963.1 2193.9 2256.9 2281.9 2227.1 2232.7 2238.1 2241.0 2243.1 2205.9 2220.5 2227.9 2307.8 2313.0 2235.1 2268.5 2269.2 2271.8 2272.8 2269.9 2283.1 2286.0 2286.4 2290.0 7041.7 7107.0 7129.1 7133.9 7137.5 4642.1 4704.2 4711.1 4739.7 4739.9 3164.1 3168.8 3296.9 3314.4 3321.3 1089.9 1106.6 1118.9 1179.9 1187.8 10441.8 10446.2 10450.3 10464.5 10467.3 4166.4 4220.8 4242.2 4307.9 4320.8 8985.8 9023.2 9027.6 9038.5 9049.5 4841.9 4848.2 4851.4 4868.7 4874.7 3835.7 4299.9 4408.5 4438.1 4490.9 3620.8 3682.2 3707.8 3728.4 3806.7 1207.5 1212.1 1215.6 1215.7 1238.2 1056.4 1058.4 1059.4 1207.8 1343.5 7335.2 7338.8 7354.4 7354.5 7388.0 1138.3 1151.3 1162.7 1168.8 1180.5 5705.9 5726.3 5730.0 5732.9 5749.5 8765.7 8935.9 9044.0 9070.8 9094.9 8768.3 8897.5 8923.6 8933.2 8968.6 6621.1 6908.0 6915.6 6959.8 6963.2 7199.6 7249.7 7266.1 7285.3 7367.3 8324.9 8472.6 8481.0 8499.7 8550.2 8441.4 8718.2 8729.2 8812.9 8828.6 6081.5 6731.0 6809.5 6845.9 6959.1 7252.2 7290.5 7307.6 7322.0 7330.3 6351.9 6490.4 6505.3 6545.7 6567.4 6207.5 6236.6 6248.5 6387.4 6399.4 6800.6 6837.8 6851.6 6876.7 6883.2 6059.3 6119.7 6164.8 6181.2 6189.7 6295.6 6324.7 6325.2 6341.7 6354.5 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | [#4] prototype.html Cycles:180 Average:5322.60 Median:6099.66 stddev:1607.47 (26.4%) stddev-sans-first:1567.65 19:12:55 INFO - PROCESS | 31095 | Values: 327.5 334.9 337.2 339.1 346.8 6003.5 6020.9 6064.3 6085.9 6092.4 5972.6 5986.5 5991.0 6003.2 6020.9 4424.2 4531.1 4580.0 4605.7 4627.0 4594.3 4616.3 4619.2 4619.6 4623.7 4581.3 4584.2 4628.5 4628.6 4643.7 4421.0 4493.8 4559.5 4562.3 4568.2 4035.3 4038.9 4052.8 4053.6 4061.8 5743.8 5807.4 5812.7 5820.3 5822.4 5334.0 5336.5 5339.9 5346.4 5349.7 6307.2 6308.4 6314.6 6315.7 6317.0 4288.3 4357.5 4372.0 4394.0 4483.2 6563.8 6577.6 6613.2 6628.1 6629.7 4502.5 4504.2 4505.1 4506.6 4508.4 4552.0 4560.0 4564.2 4565.0 4577.0 5285.5 5296.1 5299.4 5301.6 5303.5 6263.2 6411.7 6418.4 6426.5 6452.5 1557.0 1566.1 1569.4 1569.5 1572.3 980.9 1039.9 1043.1 1045.8 1062.0 6055.5 6106.9 6140.5 6185.5 6192.6 6532.9 6537.3 6539.9 6546.1 6548.2 6149.1 6193.0 6196.8 6198.0 6204.2 3494.8 3524.1 3524.7 3526.3 3530.4 6544.4 6663.6 6716.1 6720.1 6754.7 6557.8 6578.7 6601.7 6605.0 6622.8 6683.0 6722.1 6726.0 6739.5 6747.5 6517.2 6519.6 6522.2 6524.2 6529.9 6263.5 6356.1 6399.7 6403.7 6457.6 6718.5 6729.8 6730.4 6734.6 6740.1 4489.3 4492.4 4516.5 4525.3 4526.7 6502.2 6504.5 6507.2 6515.0 6518.8 6347.0 6348.1 6348.5 6351.7 6352.8 6277.7 6477.9 6477.9 6489.1 6495.0 6308.7 6352.7 6370.3 6389.0 6405.1 6554.8 6562.7 6562.8 6565.6 6569.7 6085.0 6220.6 6402.8 6448.8 6474.9 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - PROCESS | 31095 | [#5] yui.html Cycles:180 Average:15024.43 Median:25752.24 stddev:18143.43 (70.5%) stddev-sans-first:18162.22 19:12:55 INFO - PROCESS | 31095 | Values: 650.4 655.7 682.8 684.3 695.9 13223.1 13303.7 13360.5 13378.6 13390.0 11712.0 11734.0 11771.8 11841.3 12051.3 514.0 801.6 812.5 830.0 836.5 824.4 825.6 825.8 830.4 831.1 861.4 864.2 869.5 869.6 869.6 696.5 856.3 869.8 870.6 871.7 635.9 636.1 636.6 636.7 636.8 12271.4 12329.4 12342.1 12346.4 12349.9 12562.4 12791.7 12892.1 13301.8 13410.3 10111.3 10175.4 10224.4 10352.9 10479.6 3610.5 3660.0 3660.8 3698.8 3794.5 51993.0 52146.0 52193.0 52275.0 52414.7 9769.3 10040.8 10092.8 10237.6 10333.3 19939.3 19955.2 20035.5 20040.5 20060.7 7716.2 7809.1 7811.6 7815.3 8087.5 4575.7 4649.0 4761.9 4800.6 4842.2 3364.0 3430.4 3438.6 3438.6 3446.3 571.7 572.3 581.1 581.7 586.2 667.6 682.2 682.4 692.0 708.2 9295.6 9682.9 9759.6 9833.0 9844.4 563.5 596.6 692.0 703.2 739.4 4246.8 4354.5 4411.6 4530.8 4648.6 65855.3 67074.0 67204.7 67296.0 67338.3 58214.4 58872.0 59523.0 59588.4 59796.4 50861.7 51545.7 51612.5 51710.2 53067.0 8663.8 8744.4 8768.3 8911.8 9019.2 40027.8 40055.0 40584.6 40611.2 41227.0 46855.5 47078.9 48077.8 48190.0 52744.5 11098.6 11416.3 11516.4 11805.0 11976.2 12744.7 12943.7 13008.0 13085.7 13115.5 11367.7 12469.9 12543.1 12654.9 12907.0 12254.8 12603.4 12759.4 12793.0 12805.7 11130.4 11135.0 11726.7 11895.6 11906.2 10200.0 10212.5 10298.3 10335.5 10384.1 10080.6 10082.7 10351.9 10401.7 10411.7 19:12:55 INFO - PROCESS | 31095 | -------- Summary: end -------- 19:12:55 INFO - PROCESS | 31095 | 19:12:55 INFO - TEST-INFO | 31095: exit 0 19:12:55 INFO - TEST-OK | dromaeo_css | took 1111234ms 19:12:55 INFO - TEST-START | kraken 19:12:55 INFO - operating with platform_type : linux_ 19:12:55 INFO - Initialising browser for kraken test... 19:12:55 INFO - TEST-INFO | started process 31282 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpELjZEK/profile http://localhost:33745/getInfo.html) 19:13:00 INFO - PROCESS | 31282 | __metrics Screen width/height:1600/1200 19:13:00 INFO - PROCESS | 31282 | colorDepth:24 19:13:00 INFO - PROCESS | 31282 | Browser inner width/height: 1024/697 19:13:00 INFO - PROCESS | 31282 | __metrics 19:13:01 ERROR - PROCESS | 31282 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:13:02 INFO - TEST-INFO | 31282: exit 0 19:13:02 INFO - Browser initialized. 19:13:02 INFO - Running cycle 1/1 for kraken test... 19:13:02 INFO - TEST-INFO | started process 31367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpELjZEK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:13 INFO - PROCESS | 31367 | RSS: Main: 152928256 19:13:13 INFO - PROCESS | 31367 | 19:13:16 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-beat-detection) 19:13:17 INFO - PROCESS | 31367 | RSS: Main: 194895872 19:13:17 INFO - PROCESS | 31367 | 19:13:19 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-dft) 19:13:20 INFO - PROCESS | 31367 | RSS: Main: 184741888 19:13:20 INFO - PROCESS | 31367 | 19:13:23 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-fft) 19:13:23 INFO - PROCESS | 31367 | RSS: Main: 167690240 19:13:23 INFO - PROCESS | 31367 | 19:13:25 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33745/tests/kraken/driver.html?testName=audio-oscillator) 19:13:26 INFO - PROCESS | 31367 | RSS: Main: 170975232 19:13:26 INFO - PROCESS | 31367 | 19:13:28 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:29 INFO - PROCESS | 31367 | RSS: Main: 172785664 19:13:29 INFO - PROCESS | 31367 | 19:13:32 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33745/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:32 INFO - PROCESS | 31367 | RSS: Main: 173309952 19:13:32 INFO - PROCESS | 31367 | 19:13:35 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33745/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:36 INFO - PROCESS | 31367 | RSS: Main: 173826048 19:13:36 INFO - PROCESS | 31367 | 19:13:39 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33745/tests/kraken/driver.html?testName=json-parse-financial) 19:13:39 INFO - PROCESS | 31367 | RSS: Main: 173862912 19:13:39 INFO - PROCESS | 31367 | 19:13:41 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:41 INFO - PROCESS | 31367 | RSS: Main: 184438784 19:13:41 INFO - PROCESS | 31367 | 19:13:43 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:44 INFO - PROCESS | 31367 | RSS: Main: 182751232 19:13:44 INFO - PROCESS | 31367 | 19:13:46 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:46 INFO - PROCESS | 31367 | RSS: Main: 194646016 19:13:46 INFO - PROCESS | 31367 | 19:13:49 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:49 INFO - PROCESS | 31367 | RSS: Main: 200617984 19:13:49 INFO - PROCESS | 31367 | 19:13:52 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:52 INFO - PROCESS | 31367 | RSS: Main: 199491584 19:13:52 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | Cycle 1(1): loaded http://localhost:33745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33745/tests/kraken/driver.html?testName=ai-astar) 19:13:54 INFO - PROCESS | 31367 | RSS: Main: 261701632 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | __start_tp_report 19:13:54 INFO - PROCESS | 31367 | _x_x_mozilla_page_load 19:13:54 INFO - PROCESS | 31367 | _x_x_mozilla_page_load_details 19:13:54 INFO - PROCESS | 31367 | |i|pagename|runs| 19:13:54 INFO - PROCESS | 31367 | |0;ai-astar;108;109;105;109;112;110;98;109;109;109 19:13:54 INFO - PROCESS | 31367 | |1;audio-beat-detection;155;127;154;176;128;153;153;127;173;127 19:13:54 INFO - PROCESS | 31367 | |2;audio-dft;161;161;163;162;159;160;159;165;159;162 19:13:54 INFO - PROCESS | 31367 | |3;audio-fft;76;72;109;104;77;72;72;119;95;76 19:13:54 INFO - PROCESS | 31367 | |4;audio-oscillator;93;93;136;92;94;93;135;92;93;147 19:13:54 INFO - PROCESS | 31367 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;117 19:13:54 INFO - PROCESS | 31367 | |6;imaging-darkroom;146;144;145;145;145;145;145;145;145;145 19:13:54 INFO - PROCESS | 31367 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 19:13:54 INFO - PROCESS | 31367 | |8;json-parse-financial;54;56;54;54;55;56;57;69;53;51 19:13:54 INFO - PROCESS | 31367 | |9;json-stringify-tinderbox;59;60;60;59;68;61;60;60;60;59 19:13:54 INFO - PROCESS | 31367 | |10;stanford-crypto-aes;77;78;80;79;78;79;79;78;80;76 19:13:54 INFO - PROCESS | 31367 | |11;stanford-crypto-ccm;110;108;110;113;110;111;119;118;117;109 19:13:54 INFO - PROCESS | 31367 | |12;stanford-crypto-pbkdf2;143;144;153;143;143;142;142;145;142;142 19:13:54 INFO - PROCESS | 31367 | |13;stanford-crypto-sha256-iterative;64;63;66;61;63;61;62;61;62;63 19:13:54 INFO - PROCESS | 31367 | __end_tp_report 19:13:54 INFO - PROCESS | 31367 | __start_cc_report 19:13:54 INFO - PROCESS | 31367 | _x_x_mozilla_cycle_collect,1074 19:13:54 INFO - PROCESS | 31367 | __end_cc_report 19:13:54 INFO - PROCESS | 31367 | __startTimestamp1459131234854__endTimestamp 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | ------- Summary: start ------- 19:13:54 INFO - PROCESS | 31367 | Number of tests: 14 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.00 stddev:3.85 (3.5%) stddev-sans-first:4.09 19:13:54 INFO - PROCESS | 31367 | Values: 108.0 109.0 105.0 109.0 112.0 110.0 98.0 109.0 109.0 109.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:153.50 stddev:19.04 (12.4%) stddev-sans-first:19.99 19:13:54 INFO - PROCESS | 31367 | Values: 155.0 127.0 154.0 176.0 128.0 153.0 153.0 127.0 173.0 127.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.97 (1.2%) stddev-sans-first:2.09 19:13:54 INFO - PROCESS | 31367 | Values: 161.0 161.0 163.0 162.0 159.0 160.0 159.0 165.0 159.0 162.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#3] audio-fft Cycles:10 Average:87.20 Median:74.00 stddev:17.88 (24.2%) stddev-sans-first:18.50 19:13:54 INFO - PROCESS | 31367 | Values: 76.0 72.0 109.0 104.0 77.0 72.0 72.0 119.0 95.0 76.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.68 (24.4%) stddev-sans-first:23.49 19:13:54 INFO - PROCESS | 31367 | Values: 93.0 93.0 136.0 92.0 94.0 93.0 135.0 92.0 93.0 147.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:13:54 INFO - PROCESS | 31367 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 19:13:54 INFO - PROCESS | 31367 | Values: 146.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:13:54 INFO - PROCESS | 31367 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:4.91 (8.8%) stddev-sans-first:5.16 19:13:54 INFO - PROCESS | 31367 | Values: 54.0 56.0 54.0 54.0 55.0 56.0 57.0 69.0 53.0 51.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:2.67 (4.5%) stddev-sans-first:2.77 19:13:54 INFO - PROCESS | 31367 | Values: 59.0 60.0 60.0 59.0 68.0 61.0 60.0 60.0 60.0 59.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:79.00 stddev:1.26 (1.6%) stddev-sans-first:1.24 19:13:54 INFO - PROCESS | 31367 | Values: 77.0 78.0 80.0 79.0 78.0 79.0 79.0 78.0 80.0 76.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#11] stanford-crypto-ccm Cycles:10 Average:112.50 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:4.18 19:13:54 INFO - PROCESS | 31367 | Values: 110.0 108.0 110.0 113.0 110.0 111.0 119.0 118.0 117.0 109.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:143.00 stddev:3.35 (2.3%) stddev-sans-first:3.54 19:13:54 INFO - PROCESS | 31367 | Values: 143.0 144.0 153.0 143.0 143.0 142.0 142.0 145.0 142.0 142.0 19:13:54 INFO - PROCESS | 31367 | 19:13:54 INFO - PROCESS | 31367 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.59 19:13:54 INFO - PROCESS | 31367 | Values: 64.0 63.0 66.0 61.0 63.0 61.0 62.0 61.0 62.0 63.0 19:13:54 INFO - PROCESS | 31367 | -------- Summary: end -------- 19:13:54 INFO - PROCESS | 31367 | 19:13:55 INFO - TEST-INFO | 31367: exit 0 19:13:55 INFO - TEST-OK | kraken | took 59900ms 19:13:55 INFO - SUITE-END | took 1171s 19:13:56 INFO - Completed test suite (00:19:31) 19:13:56 INFO - javascript benchmark 19:13:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3055.511118221085, 3087.1973286945386, 3112.4708799504083, 3124.0940127363065, 3155.132338606883, 5087.923681144785, 5218.843434696955, 5232.47675232477, 5268.420473747885, 5278.049951008817, 5280.5247527722495, 5286.31277933868, 5290.55030322423, 5334.546563542103, 5356.38401583818, 4721.457032441279, 4756.667033307661, 4825.25208592667, 4873.098476781789, 4918.434380046305, 4793.113274044313, 4831.734254615994, 4875.341828853113, 4878.438979517366, 4879.829205977774, 4618.699784514012, 4725.574698277154, 4771.880702982418, 4785.0, 4816.4220293564995, 4790.305405716152, 4807.879803004953, 4820.566149046603, 4828.661993660445, 4854.902901941977, 4675.766211689436, 4755.643326750507, 4777.928331075037, 4790.449098353664, 4847.151748444044, 5111.821086262, 5127.743612819381, 5131.153359695646, 5144.871378215537, 5160.432352441228, 5553.333599967989, 5554.972225138848, 5557.360903496109, 5560.610757246995, 5561.332640083176, 5389.973050134763, 5574.721263936827, 5595.440455954413, 5602.38373778888, 5636.464535869086, 5257.369115706101, 5272.499112584298, 5276.657017293902, 5296.92054619181, 5318.388385335697, 5704.515116215168, 5708.429157084258, 5711.143328500675, 5711.600187986801, 5717.914231286534, 5335.1730481775385, 5399.5950303726595, 5447.727613619303, 5485.040117979338, 5492.450754924475, 5567.359753628303, 5570.888582228333, 5571.0, 5572.777088916398, 5575.052241118939, 5548.805791797267, 5550.91673624896, 5552.861178470571, 5553.750081246354, 5600.5799565032785, 5431.782728690808, 5466.508014278655, 5511.972440137773, 5536.861578460571, 5560.582956278296, 4252.170826688828, 4266.552012038754, 4270.572942705705, 4271.188474189894, 4302.763348015889, 3714.5728241252064, 3840.0975770693863, 3846.1730727893078, 3867.303885300673, 3893.649571538575, 5235.633505654568, 5266.131088370453, 5271.288376069258, 5302.787888484495, 5315.760790764425, 5550.056490396642, 5594.524465420403, 5598.440155984369, 5606.747696353674, 5607.0, 5137.51193636604, 5282.788688452496, 5295.629305948623, 5298.0463516566615, 5349.86625334362, 4856.757162141878, 4858.368412106474, 4874.634402419832, 4888.340074090023, 4922.680025798311, 5798.623089499169, 5804.738786754606, 5815.709214539341, 5822.155787410802, 5866.354700982888, 5392.892142157057, 5590.832275031756, 5631.662100273997, 5631.943680563224, 5664.943350566442, 5736.053551164178, 5752.33848107473, 5757.165211044291, 5757.280339957505, 5808.186853840551, 5489.313835770528, 5489.423610520837, 5491.615586908878, 5496.367917689357, 5507.972460137674, 5420.539254163283, 5591.049521581423, 5636.098224284095, 5735.168400581809, 5752.194692742935, 5432.619716619799, 5438.809641662523, 5442.9455705444025, 5443.891122177455, 5506.311711036121, 5395.055865223649, 5397.541208997279, 5407.270018547603, 5413.945860541344, 5450.400455949763, 5186.792528298825, 5349.1976203569775, 5420.701861397503, 5490.752916118704, 5498.202760599771, 5502.202180683858, 5525.336959564878, 5529.502344788988, 5534.86162845916, 5538.418466061005, 5406.432324605859, 5427.213054107054, 5428.972855135699, 5430.83707488776, 5432.619716619799], "unit": "score", "name": "dojo.html", "value": 5162.31470054144}, {"lowerIsBetter": false, "replicates": [506.53398873036826, 535.6545028456648, 560.3611882454002, 582.9446202610752, 596.6062398816782, 30200.84899575502, 39695.40456893149, 40083.79958100209, 40115.598844011554, 40169.59830401695, 45259.773701131446, 46085.0, 46238.30642540364, 46272.30591541129, 46285.768571157096, 7810.882836757425, 8801.163889430525, 9006.549672516348, 9006.819863602725, 9996.600135994588, 10084.14284785794, 10690.78618427631, 10711.732206694816, 10718.249722519427, 10721.624743133953, 10734.570617175343, 10834.40410777407, 10837.729056773565, 10838.72903177419, 10841.457927103653, 10649.78700425991, 10748.785024299548, 10753.193510486706, 10755.569777208902, 10757.462126893624, 10481.213908956859, 10629.468526573717, 10640.467976601216, 10643.042126208678, 10645.680629581047, 42720.0, 42914.356284655754, 43109.13781724379, 43221.78389108034, 43272.13455730899, 3121.9219519511967, 3157.7947433416984, 3163.604549431321, 3375.2236985493473, 3737.9626203738158, 32667.346653067045, 32704.83647581747, 32949.341013179845, 32995.505067424005, 33329.0, 4275.7862106894845, 4306.741595504249, 4337.587929146726, 4374.781260936972, 4391.251169861397, 326999.0, 328081.0, 328655.0, 329638.0, 329930.0, 61646.691766540884, 62124.37875621276, 62288.688556556925, 62319.376806231354, 62518.0, 69910.3008969914, 70814.29185708077, 70842.64578677074, 70870.0, 70903.0, 15829.762553561706, 15993.760093598605, 16010.27953742061, 16010.9199454002, 16017.19914004295, 11939.46272417726, 12035.638930832089, 12096.274223546616, 12099.0, 12117.515299388102, 21102.577948440947, 21243.256486022914, 21255.256066037615, 21337.78662213358, 22141.225057122923, 7386.584140188813, 7697.615119244016, 7875.684972601031, 7931.365490760841, 7936.0, 1002.1281485108003, 1023.7747695507126, 1036.1917704190744, 1042.4370839746603, 1082.9025387714985, 28662.713372866423, 29159.562606560918, 29551.85224073866, 29948.550771738443, 30252.54621180684, 1033.395463653756, 1109.4951796932376, 1143.17691262291, 1229.2992993993516, 1249.8875101240933, 15852.76220856688, 16426.507204783877, 16535.0, 16615.41846035383, 16921.576960576083, 379631.9165637553, 383517.0, 384143.0, 384384.0, 384749.0, 54327.18509222365, 54426.18360724593, 54986.0, 55035.17447238295, 55082.72458637681, 1117.9552817887193, 1357.457017193111, 1362.087401441037, 1386.3622733542684, 1393.6306878677158, 29127.0, 31499.370012600077, 33305.83347083249, 35091.473627895095, 35094.82452587721, 50717.0, 50882.49117508777, 50966.49033509766, 51530.48469515257, 51565.0, 284522.0, 287157.0, 287861.0, 288110.0, 288408.0, 41844.3723344144, 42269.36595951002, 42857.0, 43173.0, 43199.56800432081, 49634.255486167014, 49894.501054988985, 50033.749831250614, 50603.746981264856, 51344.48655513397, 41762.1647567053, 42468.78765606152, 43058.35412468878, 43135.0, 44019.55980440283, 41967.370489443296, 42549.78725106355, 42622.78688606537, 43325.78337108294, 43410.131797364505, 37227.44158837565, 37655.81172094122, 38051.80974095112, 42233.0, 43878.0, 27602.861985690746, 35199.0, 35398.64601353953, 35852.10369740777, 35866.4620030705, 27239.319017024733, 27372.863135684194, 27414.629268536894, 27535.44929101447, 27674.86162569174], "unit": "score", "name": "ext.html", "value": 20322.06131183}, {"lowerIsBetter": false, "replicates": [355.19016642056107, 358.23338056558987, 363.72720459655267, 376.3601876809425, 376.9528808898888, 17585.824141758578, 17794.28822847086, 18680.81319186811, 18696.626067478643, 18699.158537865795, 15090.39638414465, 17444.38944636938, 17446.82553174468, 17456.389026384048, 17460.214290356933, 4762.9285560716535, 5028.0, 5031.22016087507, 5037.143685573443, 5037.722925239111, 3884.6698030667285, 4910.558049775519, 5382.165764306539, 5611.80358687446, 5630.774769009235, 5601.719914004283, 5605.915911261334, 5616.6068375213545, 5620.831375058734, 5625.212470254168, 5575.609707320489, 5892.351841297454, 5910.290765108171, 6099.115628233925, 6119.051547010221, 5353.197020446964, 5377.704226267554, 5381.784728610851, 5382.219578161144, 5382.842688821883, 13662.93168534161, 20737.688934665992, 20940.476488087766, 20954.057067432, 21003.369898903056, 2284.680144779732, 2288.588054150269, 2313.5372925414986, 2317.2237300504353, 2317.617593097137, 9517.476538790364, 9555.904440955572, 9759.463229522373, 9848.606055757833, 9996.100350968447, 1904.7904730479636, 1957.0606109067585, 1973.8797835866737, 1974.8716333438424, 2029.6448121578665, 70458.29541704568, 71113.64443177803, 71149.0, 71796.64101679511, 73003.26996730018, 10029.348092373972, 10079.64721234768, 10177.745556361151, 10236.283460157718, 10246.129079028366, 13774.0, 14018.929905350407, 14019.158850469004, 14034.157950522796, 14070.0, 7494.426170504146, 7585.1656317805, 7629.771106866803, 7643.541387516767, 7701.499402538817, 7481.401487880957, 7519.248075192547, 7563.584002879785, 7586.393088552903, 7587.393008559302, 4181.26827805139, 4265.936010959838, 4266.679999000087, 4325.351197320364, 4342.457192850894, 1662.8337166283518, 1734.9306027759, 1770.663573920951, 1776.200709680649, 1829.8627602929832, 1019.2763138171832, 1024.109025148126, 1057.2916146181922, 1061.5063995242094, 1079.7138758229075, 16918.492445226664, 18164.1826117825, 18212.180451879696, 18393.17230724594, 18780.624387512446, 1006.9093781559695, 1008.7578981044496, 1036.124474818777, 1043.6816770884802, 1065.3661071662348, 9382.530873456437, 10311.793764124675, 10405.687829365132, 10409.635662751767, 10455.84316235257, 489457.0, 494662.0, 501334.0, 543468.0, 550032.0, 82014.58992704998, 86124.0, 86422.56788716016, 86678.0, 87505.0, 1027.9588816447258, 1042.2391654092555, 1045.8065257927308, 1050.5010120192846, 1052.3317693264833, 15604.531864044096, 15654.608634784221, 15853.682926341178, 15856.920715396349, 16027.439039634024, 35612.28775424425, 35705.64294357023, 36113.63886361103, 37655.435168471944, 38704.6129538701, 49131.0, 50765.746171268904, 51914.22128668149, 53081.73459132679, 53634.46365536451, 7836.882446763189, 8097.676092956216, 8193.627622290265, 8194.262516373556, 8197.426180167331, 9405.576749046173, 12970.481180753042, 13506.0, 13645.863541364857, 13717.588472345846, 9380.624775008922, 11404.0, 11448.656540303804, 11462.484188211718, 11539.480723367637, 5507.697076660822, 10253.10317591248, 10561.155107591221, 11601.0, 11960.162788604714, 11710.590129345432, 12040.879591203975, 12053.216540924812, 12295.0, 12358.567450139562, 8133.430659853753, 8178.5092894426525, 8264.297534709616, 8365.24712775853, 8417.158284171779, 11159.27464714791, 11410.14423918193, 11485.253458525169, 11549.0, 11999.460024298753], "unit": "score", "name": "jquery.html", "value": 8712.61557506442}, {"lowerIsBetter": false, "replicates": [1168.1705988747988, 1300.089937044069, 1334.7330533893223, 1411.470698488067, 1623.4155703946585, 6982.720691172353, 7084.468664850131, 7107.999999999994, 7111.324424179701, 7115.501914865961, 7122.608256545888, 7214.242504537026, 7218.639068046603, 7230.349268565828, 7249.673764680589, 1929.170456703617, 1963.1460314763053, 2193.934181974543, 2256.875871827053, 2281.931542053741, 2227.120287486442, 2232.687423760675, 2238.104758096758, 2241.0251540579898, 2243.1139699818564, 2205.933821985335, 2220.522587643656, 2227.9108835646553, 2307.7576854430295, 2312.9653055204185, 2235.0501037059184, 2268.5236100418933, 2269.1604106480545, 2271.82961277904, 2272.8181745460406, 2269.8751568663715, 2283.075354481421, 2285.954280914389, 2286.416963674252, 2289.9656505152434, 7041.683124259421, 7107.0, 7129.144502659662, 7133.928660713378, 7137.464690148259, 4642.071585682843, 4704.153252414564, 4711.128441238382, 4739.73931433771, 4739.881502962419, 3164.114048066545, 3168.825714585697, 3296.868125274986, 3314.386838434897, 3321.2693207494312, 1089.9455027248605, 1106.6016234155697, 1118.949647265875, 1179.9233049851732, 1187.7980743273665, 10441.791164176673, 10446.16430685551, 10450.268481206318, 10464.52909619069, 10467.319624224401, 4166.437530933345, 4220.78896055196, 4242.172776308652, 4307.913841723211, 4320.805563749639, 8985.775355616162, 9023.233025192932, 9027.638894444148, 9038.457692538468, 9049.457032578066, 4841.878953026132, 4848.17581011229, 4851.369321988119, 4868.683535570177, 4874.683145595525, 3835.712321575893, 4299.871003869889, 4408.493023302297, 4438.090191510732, 4490.887727806831, 3620.7827530348263, 3682.1531047859144, 3707.8134996801305, 3728.4034554471154, 3806.71449641278, 1207.4687137659403, 1212.0667086343642, 1215.5684731920219, 1215.7446936143333, 1238.1704258146883, 1056.3503445381036, 1058.4496062047847, 1059.4120263253967, 1207.782599132147, 1343.4827591377195, 7335.156457007406, 7338.816529586697, 7354.411647068222, 7354.521956072945, 7387.963060184772, 1138.322697994692, 1151.343734071588, 1162.7441962768178, 1168.7954607943575, 1180.474688763492, 5705.942940570624, 5726.255586773693, 5729.971350143306, 5732.885342293131, 5749.511291540182, 8765.693200737944, 8935.910640893508, 9043.954780226057, 9070.773230669287, 9094.909050909539, 8768.298536117096, 8897.510636914902, 8923.598438070303, 8933.196012358789, 8968.596413161424, 6621.139251897319, 6908.0, 6915.619640919697, 6959.826004349932, 6963.234044255128, 7199.604021778852, 7249.710011599477, 7266.055412796302, 7285.271472852673, 7367.314974523691, 8324.875126873223, 8472.618732156945, 8480.957595211985, 8499.660013599387, 8550.187732165434, 8441.366897482836, 8718.215360617574, 8729.170728780755, 8812.91187088121, 8828.646854125764, 6081.543884208613, 6731.0, 6809.5233333666165, 6845.897311540431, 6959.130108736408, 7252.238514955854, 7290.526115802456, 7307.561546307238, 7322.011528443805, 7330.303621155982, 6351.9047214290895, 6490.383413575702, 6505.31694172124, 6545.738170473128, 6567.44176744982, 6207.534434917309, 6236.594621349598, 6248.468880145057, 6387.361263873576, 6399.424051835357, 6800.557963732539, 6837.829054273683, 6851.588904665736, 6876.656167191721, 6883.242843287134, 6059.272887253558, 6119.663418512025, 6164.845878852885, 6181.227346581677, 6189.690515474118, 6295.590786599039, 6324.747010119544, 6325.209348831396, 6341.714622842075, 6354.491640668828], "unit": "score", "name": "mootools.html", "value": 4410.226818222049}, {"lowerIsBetter": false, "replicates": [327.4662300450266, 334.862706290421, 337.1587888218894, 339.114910084679, 346.7815276375881, 6003.489703375213, 6020.8795824083545, 6064.272287325527, 6085.878282434349, 6092.421219984094, 5972.581919265654, 5986.521078313735, 5991.0, 6003.189569408129, 6020.909686354708, 4424.225760491917, 4531.139083574127, 4580.038191979688, 4605.746683932382, 4627.028324051953, 4594.310853371988, 4616.33063205835, 4619.191641462748, 4619.607333376667, 4623.74569398683, 4581.335706322581, 4584.243599806045, 4628.467726211478, 4628.629709623222, 4643.721376717408, 4420.97789511052, 4493.752843593601, 4559.521250268707, 4562.270036794131, 4568.200564901163, 4035.273650742865, 4038.9394159087637, 4052.7770972596495, 4053.5541090480024, 4061.801768478306, 5743.770249190027, 5807.361190269067, 5812.709364531756, 5820.330661973885, 5822.359540450547, 5333.973330133324, 5336.4930331618825, 5339.866503337409, 5346.385165705955, 5349.652272602269, 6307.211598550181, 6308.432241098323, 6314.557980941336, 6315.652639104847, 6316.989281714904, 4288.270993931008, 4357.520672725997, 4372.038151606674, 4393.978030109861, 4483.237849565582, 6563.803085907431, 6577.6053436793945, 6613.173353330833, 6628.072069910217, 6629.701663425158, 4502.527234640381, 4504.189245935763, 4505.144022635689, 4506.639468842484, 4508.368828364031, 4552.0, 4560.042391097906, 4564.178447879413, 4565.0, 4576.977115114403, 5285.524302812765, 5296.1261391870685, 5299.44355842631, 5301.628885977944, 5303.4696530346655, 6263.154474146023, 6411.711472983727, 6418.422341989243, 6426.518011149183, 6452.483801295885, 1556.9844301557066, 1566.1229711361673, 1569.3722510995692, 1569.50560573419, 1572.3317590024194, 980.8822941246954, 1039.9064084232455, 1043.139409986764, 1045.8483519889726, 1062.0494657281845, 6055.5458340623745, 6106.908396374058, 6140.478059364915, 6185.474234690012, 6192.628442293477, 6532.902006469907, 6537.280899101095, 6539.934600654028, 6546.149000629983, 6548.246951600627, 6149.0776383542825, 6192.969035154795, 6196.783112591038, 6197.96901015492, 6204.193454850931, 3494.807785571818, 3524.083738228028, 3524.665156810099, 3526.347625689256, 3530.435130379127, 6544.378284063102, 6663.633500157441, 6716.093327400836, 6720.092787473628, 6754.662266886734, 6557.8360540985905, 6578.703958321887, 6601.6699165041555, 6605.0, 6622.801315960529, 6683.030960510699, 6722.1261236039, 6725.966370168216, 6739.460843132636, 6747.527673062838, 6517.152770139852, 6519.641419721961, 6522.21733391996, 6524.184476940382, 6529.9020514691365, 6263.467605253604, 6356.141920840812, 6399.6800159992745, 6403.679816009274, 6457.61254324742, 6718.462522998051, 6729.798106056826, 6730.427913627396, 6734.629595372302, 6740.056392105012, 4489.281714925727, 4492.415985921809, 4516.458025036885, 4525.298578720303, 4526.728396296233, 6502.219733631994, 6504.512161587994, 6507.219133703986, 6514.967425162844, 6518.837029074311, 6347.0, 6348.143000694847, 6348.523860710373, 6351.650659213788, 6352.809415717536, 6277.74889004453, 6477.870442591027, 6477.935220647733, 6489.059086432535, 6495.025746137928, 6308.747650094128, 6352.714127864349, 6370.299267080525, 6389.0, 6405.071264666691, 6554.80335589933, 6562.737490500326, 6562.8359291018105, 6565.573237739532, 6569.704363303758, 6085.0, 6220.626762394271, 6402.775902843378, 6448.838779030561, 6474.870502590016], "unit": "score", "name": "prototype.html", "value": 4793.8792460728655}, {"lowerIsBetter": false, "replicates": [650.4341223135873, 655.672163918041, 682.8361193313606, 684.3191024930195, 695.8712638161941, 13223.140495867774, 13303.733925321489, 13360.53238136663, 13378.598642040743, 13390.0, 11712.004479619243, 11734.0, 11771.823422648667, 11841.348725820098, 12051.276923384603, 513.9563137133348, 801.6152246921496, 812.4921923797626, 829.9543525106117, 836.45630340279, 824.3775949158377, 825.5665775467868, 825.7770401991459, 830.4436027861317, 831.0941074229089, 861.4228466927174, 864.1833467373335, 869.5130726792985, 869.5999840073574, 869.604330029835, 696.5368030259871, 856.3149480415674, 869.8434281829236, 870.6430363550977, 871.6600525794945, 635.9491240700733, 636.1443858010967, 636.5830381100386, 636.7134789344814, 636.812140418573, 12271.38643067843, 12329.445174967148, 12342.074344424114, 12346.382680865921, 12349.876501235052, 12562.434690438951, 12791.680207994781, 12892.097553171281, 13301.800472992913, 13410.329483525784, 10111.292209545334, 10175.440350780704, 10224.437655928921, 10352.896471035268, 10479.58081676732, 3610.4584312353095, 3659.963400365989, 3660.8352624131976, 3698.8335524901177, 3794.4877441545314, 51992.99999999962, 52146.0, 52193.0, 52275.0, 52414.7379263105, 9769.267304952014, 10040.79918401628, 10092.798144037079, 10237.590496380062, 10333.328333658288, 19939.302124425576, 19955.20179192845, 20035.499112522302, 20040.498987525138, 20060.69908951367, 7716.189800071024, 7809.140994490602, 7811.648475818602, 7815.25755053269, 8087.474314169678, 4575.679702420865, 4648.953510464852, 4761.857144285607, 4800.567948884617, 4842.225243960949, 3363.9663603364143, 3430.433978393537, 3438.5529881115795, 3438.638942910958, 3446.2590543033366, 571.7427157779016, 572.2646399376781, 581.137011537866, 581.6742624130416, 586.2320360327899, 667.5594107888867, 682.2330164873002, 682.4028974647184, 691.975780847678, 708.19619731605, 9295.58169882357, 9682.9031709682, 9759.560819762986, 9832.950835245778, 9844.3601165924, 563.467523190581, 596.6360520082746, 691.9861602767917, 703.1983538765811, 739.3567596191241, 4246.808893599796, 4354.455693038371, 4411.602955733999, 4530.77346132692, 4648.581627653527, 65855.34144658588, 67074.0, 67204.6639766798, 67296.0, 67338.32661673418, 58214.417855821746, 58872.0, 59523.0, 59588.404115958285, 59796.402035979954, 50861.745691272044, 51545.7422712884, 51612.48387516152, 51710.22434663483, 53066.99999999923, 8663.783405414915, 8744.387892847439, 8768.342374321825, 8911.777205569653, 9019.188273055457, 40027.79986100051, 40055.0, 40584.59415405808, 40611.18777624372, 41227.0, 46855.53144468512, 47078.87974563285, 48077.75961120172, 48190.0, 52744.47255527549, 11098.5560577576, 11416.344630028765, 11516.424178791194, 11804.993151164152, 11976.16166868311, 12744.6813829655, 12943.676408089497, 13008.0, 13085.738285234433, 13115.475380984653, 11367.658970230907, 12469.937650312053, 12543.12198146121, 12654.936725316315, 12907.0, 12254.816177757519, 12603.432845521791, 12759.362031898554, 12792.976561875214, 12805.743885122432, 11130.443477826238, 11135.0, 11726.70683232926, 11895.583654572049, 11906.166568340479, 10200.030997055268, 10212.540435680263, 10298.330608510423, 10335.483225838829, 10384.065434110664, 10080.647177348757, 10082.69751907444, 10351.896481035094, 10401.68794936153, 10411.739706507398], "unit": "score", "name": "yui.html", "value": 6581.74654320998}], "name": "dromaeo_css", "value": 7091.674879418419}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 109.0, 112.0, 110.0, 98.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 154.0, 176.0, 128.0, 153.0, 153.0, 127.0, 173.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 162.0, 159.0, 160.0, 159.0, 165.0, 159.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 109.0, 104.0, 77.0, 72.0, 72.0, 119.0, 95.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 92.0, 94.0, 93.0, 135.0, 92.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 54.0, 54.0, 55.0, 56.0, 57.0, 69.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 60.0, 59.0, 68.0, 61.0, 60.0, 60.0, 60.0, 59.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.6}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 80.0, 79.0, 78.0, 79.0, 79.0, 78.0, 80.0, 76.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.4}, {"lowerIsBetter": true, "replicates": [110.0, 108.0, 110.0, 113.0, 110.0, 111.0, 119.0, 118.0, 117.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.5}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 153.0, 143.0, 143.0, 142.0, 142.0, 145.0, 142.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 66.0, 61.0, 63.0, 61.0, 62.0, 61.0, 62.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.6}], "name": "kraken", "value": 1480.8}]} 19:13:56 INFO - Return code: 0 19:13:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:13:56 ERROR - # TBPL SUCCESS # 19:13:56 INFO - Running post-action listener: _resource_record_post_action 19:13:56 INFO - Running post-run listener: _resource_record_post_run 19:13:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 28672; Write bytes: 537853952; Read time: 444; Write time: 595552 19:13:57 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 195788800; Read time: 168; Write time: 320432 19:13:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 24576; Write bytes: 294723584; Read time: 276; Write time: 256500 19:13:57 INFO - Running post-run listener: _upload_blobber_files 19:13:57 INFO - Blob upload gear active. 19:13:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:13:57 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 19:13:57 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'] 19:13:57 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 19:13:57 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:13:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:13:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:58 INFO - (blobuploader) - INFO - Done attempting. 19:13:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:13:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:13:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:59 INFO - (blobuploader) - INFO - Done attempting. 19:13:59 INFO - (blobuploader) - INFO - Iteration through files over. 19:13:59 INFO - Return code: 0 19:13:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:13:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:13:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f000e7464f9cd530081933c7de3e595b7c75cfe6e8ed5aac778d2fb0312663a96618c25a51f3891ad1625371f57f6cc24de51a0ab2653a9378264c4b1e68d358", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/815449be40a8aad2c6711c6cc27e2710014de47a178714266ba5ac0dc15304ad7e7f02b12717f67cdf360457a6859e9fa154f0ae9034fdb9ace28ded7d7d8f2e"} 19:13:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:13:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:13:59 INFO - Contents: 19:13:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f000e7464f9cd530081933c7de3e595b7c75cfe6e8ed5aac778d2fb0312663a96618c25a51f3891ad1625371f57f6cc24de51a0ab2653a9378264c4b1e68d358", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/815449be40a8aad2c6711c6cc27e2710014de47a178714266ba5ac0dc15304ad7e7f02b12717f67cdf360457a6859e9fa154f0ae9034fdb9ace28ded7d7d8f2e"} 19:13:59 INFO - Running post-run listener: copy_logs_to_upload_dir 19:13:59 INFO - Copying logs to upload dir... 19:13:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:13:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.173413 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-27 19:13:58.601851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-27 19:13:58.605079) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f000e7464f9cd530081933c7de3e595b7c75cfe6e8ed5aac778d2fb0312663a96618c25a51f3891ad1625371f57f6cc24de51a0ab2653a9378264c4b1e68d358", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/815449be40a8aad2c6711c6cc27e2710014de47a178714266ba5ac0dc15304ad7e7f02b12717f67cdf360457a6859e9fa154f0ae9034fdb9ace28ded7d7d8f2e"} build_url:https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f000e7464f9cd530081933c7de3e595b7c75cfe6e8ed5aac778d2fb0312663a96618c25a51f3891ad1625371f57f6cc24de51a0ab2653a9378264c4b1e68d358", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/815449be40a8aad2c6711c6cc27e2710014de47a178714266ba5ac0dc15304ad7e7f02b12717f67cdf360457a6859e9fa154f0ae9034fdb9ace28ded7d7d8f2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-27 19:13:58.637774) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 19:13:58.638510) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459125793.481433-349328064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 19:13:58.723195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-27 19:13:58.723909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-27 19:13:58.724552) ========= ========= Total master_lag: 0.30 =========