builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1450369894.72 results: success (0) buildid: 20151217053002 builduid: 9551afb79ed2457ea95a0385574b495d revision: cac1c9da152be905dc1cb31fcc33a2cad12fceb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.716720) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.717195) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.717502) ========= 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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.741852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.742207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.772533) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.772933) ========= 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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.008458 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.819634) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.819970) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.820373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:34.820764) ========= 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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 08:31:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.0M=0.001s 2015-12-17 08:31:35 (21.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.019088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.019421) ========= 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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.116911 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.147743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.148123) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev cac1c9da152be905dc1cb31fcc33a2cad12fceb5 --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/b2g-inbound --rev cac1c9da152be905dc1cb31fcc33a2cad12fceb5 --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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 08:31:35,276 truncating revision to first 12 chars 2015-12-17 08:31:35,276 Setting DEBUG logging. 2015-12-17 08:31:35,276 attempt 1/10 2015-12-17 08:31:35,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/cac1c9da152b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 08:31:35,522 unpacking tar archive at: b2g-inbound-cac1c9da152b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.715628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.715964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.724756) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.725133) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:31:35.725580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-17 08:31:35.725870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:31:35 INFO - MultiFileLogger online at 20151217 08:31:35 in /builds/slave/test-pgo 08:31:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 08:31:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:31:35 INFO - {'append_to_log': False, 08:31:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:31:35 INFO - 'blob_upload_branch': 'B2G-Inbound', 08:31:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:31:35 INFO - 'branch': 'B2G-Inbound', 08:31:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:31:35 INFO - 'config_files': ('talos/linux_config.py',), 08:31:35 INFO - 'default_actions': ('clobber', 08:31:35 INFO - 'read-buildbot-config', 08:31:35 INFO - 'download-and-extract', 08:31:35 INFO - 'populate-webroot', 08:31:35 INFO - 'create-virtualenv', 08:31:35 INFO - 'install', 08:31:35 INFO - 'run-tests'), 08:31:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:31:35 INFO - 'download_minidump_stackwalk': True, 08:31:35 INFO - 'download_symbols': 'ondemand', 08:31:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:31:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:31:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:31:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:31:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:31:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:31:35 INFO - 'installer_path': 'installer.exe', 08:31:35 INFO - 'log_level': 'info', 08:31:35 INFO - 'log_name': 'talos', 08:31:35 INFO - 'log_to_console': True, 08:31:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:31:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:31:35 INFO - 'opt_config_files': (), 08:31:35 INFO - 'pip_index': False, 08:31:35 INFO - 'sps_profile': False, 08:31:35 INFO - 'sps_profile_interval': 0, 08:31:35 INFO - 'suite': 'dromaeojs', 08:31:35 INFO - 'system_bits': '64', 08:31:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:31:35 INFO - 'title': 'talos-linux64-ix-047', 08:31:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:31:35 INFO - 'use_talos_json': True, 08:31:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:31:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:31:35 INFO - 'work_dir': 'build'} 08:31:35 INFO - ##### 08:31:35 INFO - ##### Running clobber step. 08:31:35 INFO - ##### 08:31:35 INFO - Running pre-action listener: _resource_record_pre_action 08:31:35 INFO - Running main action method: clobber 08:31:35 INFO - rmtree: /builds/slave/test-pgo/build 08:31:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:31:40 INFO - Running post-action listener: _resource_record_post_action 08:31:40 INFO - ##### 08:31:40 INFO - ##### Running read-buildbot-config step. 08:31:40 INFO - ##### 08:31:40 INFO - Running pre-action listener: _resource_record_pre_action 08:31:40 INFO - Running main action method: read_buildbot_config 08:31:40 INFO - Using buildbot properties: 08:31:40 INFO - { 08:31:40 INFO - "project": "", 08:31:40 INFO - "product": "firefox", 08:31:40 INFO - "script_repo_revision": "production", 08:31:40 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:31:40 INFO - "repository": "", 08:31:40 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 08:31:40 INFO - "buildid": "20151217053002", 08:31:40 INFO - "pgo_build": "True", 08:31:40 INFO - "basedir": "/builds/slave/test-pgo", 08:31:40 INFO - "buildnumber": 131, 08:31:40 INFO - "slavename": "talos-linux64-ix-047", 08:31:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:31:40 INFO - "platform": "ubuntu64_hw", 08:31:40 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 08:31:40 INFO - "branch": "b2g-inbound", 08:31:40 INFO - "repo_path": "integration/b2g-inbound", 08:31:40 INFO - "revision": "cac1c9da152be905dc1cb31fcc33a2cad12fceb5", 08:31:40 INFO - "stage_platform": "linux64-pgo", 08:31:40 INFO - "builduid": "9551afb79ed2457ea95a0385574b495d", 08:31:40 INFO - "slavebuilddir": "test" 08:31:40 INFO - } 08:31:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:31:40 INFO - Running post-action listener: _resource_record_post_action 08:31:40 INFO - ##### 08:31:40 INFO - ##### Running download-and-extract step. 08:31:40 INFO - ##### 08:31:40 INFO - Running pre-action listener: _resource_record_pre_action 08:31:40 INFO - Running main action method: download_and_extract 08:31:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:31:40 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')]} 08:31:40 INFO - https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/test_packages.json 08:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/test_packages.json 08:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:31:41 INFO - Downloaded 1302 bytes. 08:31:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:31:41 INFO - Using the following test package requirements: 08:31:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:31:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:31:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:41 INFO - u'jsshell-linux-x86_64.zip'], 08:31:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:31:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:31:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:31:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:31:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:31:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:31:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:31:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:31:41 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')]} 08:31:41 INFO - https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:31:43 INFO - Downloaded 23119622 bytes. 08:31:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:31:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:31:44 INFO - Return code: 0 08:31:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:31:44 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')]} 08:31:44 INFO - https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:31:45 INFO - Downloaded 23119622 bytes. 08:31:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:31:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:31:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:31:47 INFO - Return code: 0 08:31:47 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')]} 08:31:47 INFO - https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:31:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:31:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:31:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:31:48 INFO - Downloaded 11132039 bytes. 08:31:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 08:31:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:31:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:31:48 INFO - Return code: 0 08:31: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')]} 08:31:48 INFO - https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:31:50 INFO - Downloaded 54637901 bytes. 08:31:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:31:50 INFO - mkdir: /builds/slave/test-pgo/properties 08:31:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:31:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:31:50 INFO - Contents: 08:31:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:31:50 INFO - Running post-action listener: _resource_record_post_action 08:31:50 INFO - Running post-action listener: set_extra_try_arguments 08:31:50 INFO - ##### 08:31:50 INFO - ##### Running populate-webroot step. 08:31:50 INFO - ##### 08:31:50 INFO - Running pre-action listener: _resource_record_pre_action 08:31:50 INFO - Running main action method: populate_webroot 08:31:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:50 INFO - '--tppagecycles', 08:31:50 INFO - '7'], 08:31:50 INFO - 'tests': ['tsvgm']}}, 08:31:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:31:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:31:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:31:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'tests': ['damp', 'tps']}, 08:31:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['damp', 'tps']}, 08:31:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:31:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:50 INFO - 'other': {'tests': ['a11yr', 08:31:50 INFO - 'ts_paint', 08:31:50 INFO - 'tpaint', 08:31:50 INFO - 'sessionrestore', 08:31:50 INFO - 'sessionrestore_no_auto_restore']}, 08:31:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['a11yr', 08:31:50 INFO - 'ts_paint', 08:31:50 INFO - 'tpaint', 08:31:50 INFO - 'sessionrestore', 08:31:50 INFO - 'sessionrestore_no_auto_restore']}, 08:31:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['a11yr', 08:31:50 INFO - 'ts_paint', 08:31:50 INFO - 'tpaint', 08:31:50 INFO - 'sessionrestore', 08:31:50 INFO - 'sessionrestore_no_auto_restore']}, 08:31:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['a11yr', 08:31:50 INFO - 'ts_paint', 08:31:50 INFO - 'tpaint', 08:31:50 INFO - 'sessionrestore', 08:31:50 INFO - 'sessionrestore_no_auto_restore']}, 08:31:50 INFO - 'other_l64': {'tests': ['a11yr', 08:31:50 INFO - 'ts_paint', 08:31:50 INFO - 'tpaint', 08:31:50 INFO - 'sessionrestore', 08:31:50 INFO - 'sessionrestore_no_auto_restore']}, 08:31:50 INFO - 'other_nol64': {'tests': ['a11yr', 08:31:50 INFO - 'ts_paint', 08:31:50 INFO - 'tpaint', 08:31:50 INFO - 'sessionrestore', 08:31:50 INFO - 'sessionrestore_no_auto_restore']}, 08:31:50 INFO - 'svgr': {'tests': ['tsvgx', 08:31:50 INFO - 'tsvgr_opacity', 08:31:50 INFO - 'tart', 08:31:50 INFO - 'tscrollx', 08:31:50 INFO - 'cart']}, 08:31:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['tsvgx', 08:31:50 INFO - 'tsvgr_opacity', 08:31:50 INFO - 'tart', 08:31:50 INFO - 'tscrollx', 08:31:50 INFO - 'cart']}, 08:31:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'tests': ['tp5o']}, 08:31:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'talos_options': ['--e10s'], 08:31:50 INFO - 'tests': ['tp5o']}, 08:31:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'talos_options': ['--xperf_path', 08:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:50 INFO - 'tests': ['tp5n']}, 08:31:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:50 INFO - 'talos_options': ['--e10s', 08:31:50 INFO - '--xperf_path', 08:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:50 INFO - 'tests': ['tp5n']}}, 08:31:50 INFO - 'talos.zip': {'path': '', 08:31:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:50 INFO - Running post-action listener: _resource_record_post_action 08:31:50 INFO - ##### 08:31:50 INFO - ##### Running create-virtualenv step. 08:31:50 INFO - ##### 08:31:50 INFO - Running pre-action listener: _resource_record_pre_action 08:31:50 INFO - Running main action method: create_virtualenv 08:31:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:31:50 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 08:31:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:31:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:50 INFO - Using real prefix '/usr' 08:31:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:31:51 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:53 INFO - Installing pip.................done. 08:31:53 INFO - Return code: 0 08:31:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:31:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:31:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:31:53 INFO - Using env: {'DISPLAY': ':0', 08:31:53 INFO - 'HOME': '/home/cltbld', 08:31:53 INFO - 'LANG': 'en_US.UTF-8', 08:31:53 INFO - 'LANGUAGE': 'en_US:en', 08:31:53 INFO - 'LOGNAME': 'cltbld', 08:31:53 INFO - 'MAIL': '/var/mail/cltbld', 08:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:53 INFO - 'MOZ_NO_REMOTE': '1', 08:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:53 INFO - 'NO_EM_RESTART': '1', 08:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:53 INFO - 'SHELL': '/bin/bash', 08:31:53 INFO - 'SHLVL': '1', 08:31:53 INFO - 'TERM': 'linux', 08:31:53 INFO - 'TMOUT': '86400', 08:31:53 INFO - 'USER': 'cltbld', 08:31:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:53 INFO - '_': '/tools/buildbot/bin/python'} 08:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:53 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 08:31:53 INFO - Cleaning up... 08:31:53 INFO - Return code: 0 08:31:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:31:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:31:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:31:53 INFO - Using env: {'DISPLAY': ':0', 08:31:53 INFO - 'HOME': '/home/cltbld', 08:31:53 INFO - 'LANG': 'en_US.UTF-8', 08:31:53 INFO - 'LANGUAGE': 'en_US:en', 08:31:53 INFO - 'LOGNAME': 'cltbld', 08:31:53 INFO - 'MAIL': '/var/mail/cltbld', 08:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:53 INFO - 'MOZ_NO_REMOTE': '1', 08:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:53 INFO - 'NO_EM_RESTART': '1', 08:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:53 INFO - 'SHELL': '/bin/bash', 08:31:53 INFO - 'SHLVL': '1', 08:31:53 INFO - 'TERM': 'linux', 08:31:53 INFO - 'TMOUT': '86400', 08:31:53 INFO - 'USER': 'cltbld', 08:31:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:53 INFO - '_': '/tools/buildbot/bin/python'} 08:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:53 INFO - Downloading/unpacking psutil>=0.7.1 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:31:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:31:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:55 INFO - Installing collected packages: psutil 08:31:55 INFO - Running setup.py install for psutil 08:31:55 INFO - building 'psutil._psutil_linux' extension 08:31:55 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 08:31:55 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 08:31:55 INFO - building 'psutil._psutil_posix' extension 08:31:55 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 08:31:55 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 08:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:55 INFO - Successfully installed psutil 08:31:55 INFO - Cleaning up... 08:31:56 INFO - Return code: 0 08:31:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:31:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:31:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:31:56 INFO - Using env: {'DISPLAY': ':0', 08:31:56 INFO - 'HOME': '/home/cltbld', 08:31:56 INFO - 'LANG': 'en_US.UTF-8', 08:31:56 INFO - 'LANGUAGE': 'en_US:en', 08:31:56 INFO - 'LOGNAME': 'cltbld', 08:31:56 INFO - 'MAIL': '/var/mail/cltbld', 08:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:56 INFO - 'MOZ_NO_REMOTE': '1', 08:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:56 INFO - 'NO_EM_RESTART': '1', 08:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:56 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:56 INFO - 'SHELL': '/bin/bash', 08:31:56 INFO - 'SHLVL': '1', 08:31:56 INFO - 'TERM': 'linux', 08:31:56 INFO - 'TMOUT': '86400', 08:31:56 INFO - 'USER': 'cltbld', 08:31:56 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:56 INFO - '_': '/tools/buildbot/bin/python'} 08:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:31:56 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 08:31:56 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 08:31:56 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 08:31:56 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 08:31:56 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 08:31:56 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 08:31:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:31:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:31:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:31:58 INFO - Installing collected packages: mozsystemmonitor 08:31:58 INFO - Running setup.py install for mozsystemmonitor 08:31:58 INFO - Successfully installed mozsystemmonitor 08:31:58 INFO - Cleaning up... 08:31:58 INFO - Return code: 0 08:31:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:31:58 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')]} 08:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:58 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')]} 08:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:31:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:31:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:31:58 INFO - Using env: {'DISPLAY': ':0', 08:31:58 INFO - 'HOME': '/home/cltbld', 08:31:58 INFO - 'LANG': 'en_US.UTF-8', 08:31:58 INFO - 'LANGUAGE': 'en_US:en', 08:31:58 INFO - 'LOGNAME': 'cltbld', 08:31:58 INFO - 'MAIL': '/var/mail/cltbld', 08:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:58 INFO - 'MOZ_NO_REMOTE': '1', 08:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:58 INFO - 'NO_EM_RESTART': '1', 08:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:58 INFO - 'SHELL': '/bin/bash', 08:31:58 INFO - 'SHLVL': '1', 08:31:58 INFO - 'TERM': 'linux', 08:31:58 INFO - 'TMOUT': '86400', 08:31:58 INFO - 'USER': 'cltbld', 08:31:58 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:58 INFO - '_': '/tools/buildbot/bin/python'} 08:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:32:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:32:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 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 08:32:00 INFO - Downloading docopt-0.6.1.tar.gz 08:32:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:00 INFO - Running setup.py install for blobuploader 08:32:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:32:00 INFO - Running setup.py install for requests 08:32:01 INFO - Running setup.py install for docopt 08:32:01 INFO - Successfully installed blobuploader requests docopt 08:32:01 INFO - Cleaning up... 08:32:01 INFO - Return code: 0 08:32:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:32: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')]} 08:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:32:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:32:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:01 INFO - Using env: {'DISPLAY': ':0', 08:32:01 INFO - 'HOME': '/home/cltbld', 08:32:01 INFO - 'LANG': 'en_US.UTF-8', 08:32:01 INFO - 'LANGUAGE': 'en_US:en', 08:32:01 INFO - 'LOGNAME': 'cltbld', 08:32:01 INFO - 'MAIL': '/var/mail/cltbld', 08:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:01 INFO - 'MOZ_NO_REMOTE': '1', 08:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:01 INFO - 'NO_EM_RESTART': '1', 08:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:01 INFO - 'SHELL': '/bin/bash', 08:32:01 INFO - 'SHLVL': '1', 08:32:01 INFO - 'TERM': 'linux', 08:32:01 INFO - 'TMOUT': '86400', 08:32:01 INFO - 'USER': 'cltbld', 08:32:01 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:01 INFO - '_': '/tools/buildbot/bin/python'} 08:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:32:01 INFO - Running setup.py (path:/tmp/pip-6twvRi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:32:01 INFO - Running setup.py (path:/tmp/pip-PdfASe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:32:01 INFO - Running setup.py (path:/tmp/pip-oMTKnG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:32:01 INFO - Running setup.py (path:/tmp/pip-mYGYDM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:32:01 INFO - Running setup.py (path:/tmp/pip-Wga1rR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:32:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:32:01 INFO - Running setup.py (path:/tmp/pip-mMh0oq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:32:02 INFO - Running setup.py (path:/tmp/pip-k0YJ3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:32:02 INFO - Running setup.py (path:/tmp/pip-ynK2VL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:32:02 INFO - Running setup.py (path:/tmp/pip-15JFEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:32:02 INFO - Running setup.py (path:/tmp/pip-4uMroe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:32:02 INFO - Running setup.py (path:/tmp/pip-e7fFRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:32:02 INFO - Running setup.py (path:/tmp/pip-2ZUANT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:32:02 INFO - Running setup.py (path:/tmp/pip-2yxVr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:32:02 INFO - Running setup.py (path:/tmp/pip-NcJ52m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:32:02 INFO - Running setup.py (path:/tmp/pip-ptzbPX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:32:02 INFO - Running setup.py (path:/tmp/pip-BnZ9fF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:32:02 INFO - Running setup.py (path:/tmp/pip-5iQN6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:32:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:02 INFO - Running setup.py install for manifestparser 08:32:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:32:02 INFO - Running setup.py install for mozcrash 08:32:03 INFO - Running setup.py install for mozdebug 08:32:03 INFO - Running setup.py install for mozdevice 08:32:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Running setup.py install for mozfile 08:32:03 INFO - Running setup.py install for mozhttpd 08:32:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Running setup.py install for mozinfo 08:32:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Running setup.py install for mozInstall 08:32:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Running setup.py install for mozleak 08:32:03 INFO - Running setup.py install for mozlog 08:32:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Running setup.py install for moznetwork 08:32:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:32:03 INFO - Running setup.py install for mozprocess 08:32:04 INFO - Running setup.py install for mozprofile 08:32:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:32:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:32:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:32:04 INFO - Running setup.py install for mozrunner 08:32:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:32:04 INFO - Running setup.py install for mozscreenshot 08:32:04 INFO - Running setup.py install for moztest 08:32:04 INFO - Running setup.py install for mozversion 08:32:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:32:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:04 INFO - Cleaning up... 08:32:04 INFO - Return code: 0 08:32:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:32:04 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')]} 08:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:04 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')]} 08:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:32:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:32:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:04 INFO - Using env: {'DISPLAY': ':0', 08:32:04 INFO - 'HOME': '/home/cltbld', 08:32:04 INFO - 'LANG': 'en_US.UTF-8', 08:32:04 INFO - 'LANGUAGE': 'en_US:en', 08:32:04 INFO - 'LOGNAME': 'cltbld', 08:32:04 INFO - 'MAIL': '/var/mail/cltbld', 08:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:04 INFO - 'MOZ_NO_REMOTE': '1', 08:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:04 INFO - 'NO_EM_RESTART': '1', 08:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:04 INFO - 'SHELL': '/bin/bash', 08:32:04 INFO - 'SHLVL': '1', 08:32:04 INFO - 'TERM': 'linux', 08:32:04 INFO - 'TMOUT': '86400', 08:32:04 INFO - 'USER': 'cltbld', 08:32:04 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:04 INFO - '_': '/tools/buildbot/bin/python'} 08:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:32:04 INFO - Running setup.py (path:/tmp/pip-LQY806-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:32:04 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)) 08:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:32:04 INFO - Running setup.py (path:/tmp/pip-wD96TQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:32:04 INFO - Running setup.py (path:/tmp/pip-hZ33HT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:32:05 INFO - Running setup.py (path:/tmp/pip-lm_VDL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:32:05 INFO - Running setup.py (path:/tmp/pip-miGbcL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:32:05 INFO - Running setup.py (path:/tmp/pip-3rJJ9l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:32:05 INFO - Running setup.py (path:/tmp/pip-LF0z5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:32:05 INFO - Running setup.py (path:/tmp/pip-qiQ49W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:32:05 INFO - Running setup.py (path:/tmp/pip-2V2QV4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:32:05 INFO - Running setup.py (path:/tmp/pip-QxyM42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:32:05 INFO - Running setup.py (path:/tmp/pip-zxldjF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:32:05 INFO - Running setup.py (path:/tmp/pip-xTXrA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:32:05 INFO - Running setup.py (path:/tmp/pip-BJZ1PR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:32:05 INFO - Running setup.py (path:/tmp/pip-YC1uBp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:32:05 INFO - Running setup.py (path:/tmp/pip-627kju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:32:05 INFO - Running setup.py (path:/tmp/pip-TVSnzb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:32:05 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)) 08:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:32:05 INFO - Running setup.py (path:/tmp/pip-ulxh4j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:32:06 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)) 08:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:06 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)) 08:32:06 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:06 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:07 INFO - Downloading blessings-1.5.1.tar.gz 08:32:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:32:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:07 INFO - Installing collected packages: blessings 08:32:07 INFO - Running setup.py install for blessings 08:32:07 INFO - Successfully installed blessings 08:32:07 INFO - Cleaning up... 08:32:07 INFO - Return code: 0 08:32:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:32:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:32:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:32:08 INFO - Reading from file tmpfile_stdout 08:32:08 INFO - Current package versions: 08:32:08 INFO - argparse == 1.2.1 08:32:08 INFO - blessings == 1.5.1 08:32:08 INFO - blobuploader == 1.2.4 08:32:08 INFO - docopt == 0.6.1 08:32:08 INFO - manifestparser == 1.1 08:32:08 INFO - mozInstall == 1.12 08:32:08 INFO - mozcrash == 0.16 08:32:08 INFO - mozdebug == 0.1 08:32:08 INFO - mozdevice == 0.47 08:32:08 INFO - mozfile == 1.2 08:32:08 INFO - mozhttpd == 0.7 08:32:08 INFO - mozinfo == 0.9 08:32:08 INFO - mozleak == 0.1 08:32:08 INFO - mozlog == 3.1 08:32:08 INFO - moznetwork == 0.27 08:32:08 INFO - mozprocess == 0.22 08:32:08 INFO - mozprofile == 0.27 08:32:08 INFO - mozrunner == 6.11 08:32:08 INFO - mozscreenshot == 0.1 08:32:08 INFO - mozsystemmonitor == 0.0 08:32:08 INFO - moztest == 0.7 08:32:08 INFO - mozversion == 1.4 08:32:08 INFO - psutil == 3.1.1 08:32:08 INFO - requests == 1.2.3 08:32:08 INFO - wsgiref == 0.1.2 08:32:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:32:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:32:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:08 INFO - Using env: {'DISPLAY': ':0', 08:32:08 INFO - 'HOME': '/home/cltbld', 08:32:08 INFO - 'LANG': 'en_US.UTF-8', 08:32:08 INFO - 'LANGUAGE': 'en_US:en', 08:32:08 INFO - 'LOGNAME': 'cltbld', 08:32:08 INFO - 'MAIL': '/var/mail/cltbld', 08:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:08 INFO - 'MOZ_NO_REMOTE': '1', 08:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:08 INFO - 'NO_EM_RESTART': '1', 08:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:08 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:08 INFO - 'SHELL': '/bin/bash', 08:32:08 INFO - 'SHLVL': '1', 08:32:08 INFO - 'TERM': 'linux', 08:32:08 INFO - 'TMOUT': '86400', 08:32:08 INFO - 'USER': 'cltbld', 08:32:08 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:08 INFO - '_': '/tools/buildbot/bin/python'} 08:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:08 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 1)) 08:32:08 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 2)) 08:32:08 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 3)) 08:32:08 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 4)) 08:32:08 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 5)) 08:32:08 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 6)) 08:32:08 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 7)) 08:32:08 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 8)) 08:32:08 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:32:08 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 3)) 08:32:08 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:32:08 INFO - Cleaning up... 08:32:08 INFO - Return code: 0 08:32:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:32:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:32:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:32:08 INFO - Using env: {'DISPLAY': ':0', 08:32:08 INFO - 'HOME': '/home/cltbld', 08:32:08 INFO - 'LANG': 'en_US.UTF-8', 08:32:08 INFO - 'LANGUAGE': 'en_US:en', 08:32:08 INFO - 'LOGNAME': 'cltbld', 08:32:08 INFO - 'MAIL': '/var/mail/cltbld', 08:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:08 INFO - 'MOZ_NO_REMOTE': '1', 08:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:08 INFO - 'NO_EM_RESTART': '1', 08:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:08 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:08 INFO - 'SHELL': '/bin/bash', 08:32:08 INFO - 'SHLVL': '1', 08:32:08 INFO - 'TERM': 'linux', 08:32:08 INFO - 'TMOUT': '86400', 08:32:08 INFO - 'USER': 'cltbld', 08:32:08 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:08 INFO - '_': '/tools/buildbot/bin/python'} 08:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:08 INFO - Downloading/unpacking jsonschema 08:32:08 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 08:32:08 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 08:32:08 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 08:32:08 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 08:32:08 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 08:32:08 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 08:32:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:32:10 INFO - Downloading/unpacking functools32 (from jsonschema) 08:32:10 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 08:32:10 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 08:32:10 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 08:32:10 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 08:32:10 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 08:32:10 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 08:32:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:32:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:10 INFO - warning: no files found matching '*.txt' 08:32:10 INFO - no previously-included directories found matching 'build' 08:32:10 INFO - no previously-included directories found matching 'dist' 08:32:10 INFO - no previously-included directories found matching '.git*' 08:32:10 INFO - Installing collected packages: jsonschema, functools32 08:32:10 INFO - Running setup.py install for functools32 08:32:10 INFO - warning: no files found matching '*.txt' 08:32:10 INFO - no previously-included directories found matching 'build' 08:32:10 INFO - no previously-included directories found matching 'dist' 08:32:10 INFO - no previously-included directories found matching '.git*' 08:32:10 INFO - Successfully installed jsonschema functools32 08:32:10 INFO - Cleaning up... 08:32:10 INFO - Return code: 0 08:32:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:32:10 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')]} 08:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:10 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')]} 08:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ac70cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', '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 08:32:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:32:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:32:10 INFO - Using env: {'DISPLAY': ':0', 08:32:10 INFO - 'HOME': '/home/cltbld', 08:32:10 INFO - 'LANG': 'en_US.UTF-8', 08:32:10 INFO - 'LANGUAGE': 'en_US:en', 08:32:10 INFO - 'LOGNAME': 'cltbld', 08:32:10 INFO - 'MAIL': '/var/mail/cltbld', 08:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:10 INFO - 'MOZ_NO_REMOTE': '1', 08:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:10 INFO - 'NO_EM_RESTART': '1', 08:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:10 INFO - 'SHELL': '/bin/bash', 08:32:10 INFO - 'SHLVL': '1', 08:32:10 INFO - 'TERM': 'linux', 08:32:10 INFO - 'TMOUT': '86400', 08:32:10 INFO - 'USER': 'cltbld', 08:32:10 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:10 INFO - '_': '/tools/buildbot/bin/python'} 08:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:10 INFO - Downloading/unpacking flake8 08:32:10 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 08:32:10 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 08:32:10 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 08:32:10 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 08:32:10 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 08:32:10 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 08:32:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:32:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:32:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:32:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:32:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:32:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:32:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:32:13 INFO - no previously-included directories found matching 'docs/_build' 08:32:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:32:13 INFO - Running setup.py install for pep8 08:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:32:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:32:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:32:13 INFO - no previously-included directories found matching 'docs/_build' 08:32:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:32:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:32:13 INFO - Cleaning up... 08:32:13 INFO - Return code: 0 08:32:13 INFO - Running post-action listener: _resource_record_post_action 08:32:13 INFO - Running post-action listener: _start_resource_monitoring 08:32:13 INFO - Starting resource monitoring. 08:32:13 INFO - ##### 08:32:13 INFO - ##### Running install step. 08:32:13 INFO - ##### 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: install 08:32:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:32:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:32:13 INFO - Reading from file tmpfile_stdout 08:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:32:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:32:13 INFO - Reading from file tmpfile_stdout 08:32:13 INFO - Output received: 08:32:13 INFO - Usage: mozinstall [options] installer 08:32:13 INFO - Options: 08:32:13 INFO - -h, --help show this help message and exit 08:32:13 INFO - -d DEST, --destination=DEST 08:32:13 INFO - Directory to install application into. [default: 08:32:13 INFO - "/builds/slave/test-pgo"] 08:32:13 INFO - --app=APP Application being installed. [default: firefox] 08:32:13 INFO - mkdir: /builds/slave/test-pgo/build/application 08:32:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:32:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:32:29 INFO - Reading from file tmpfile_stdout 08:32:29 INFO - Output received: 08:32:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:32:29 INFO - Running post-action listener: _resource_record_post_action 08:32:29 INFO - ##### 08:32:29 INFO - ##### Running run-tests step. 08:32:29 INFO - ##### 08:32:29 INFO - Running pre-action listener: _resource_record_pre_action 08:32:29 INFO - Running main action method: run_tests 08:32:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:32:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:32:29 INFO - Python 2.7.3 08:32:29 INFO - Return code: 0 08:32:29 INFO - grabbing minidump binary from tooltool 08:32:29 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')]} 08:32:29 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 0x149a350>, '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 0x149b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149b6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:32:29 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 08:32:29 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 08:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:29 INFO - Return code: 0 08:32:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:32:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:32:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:32:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:32:30 INFO - Return code: 0 08:32:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:32:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 08:32:30 INFO - Using env: {'DISPLAY': ':0', 08:32:30 INFO - 'HOME': '/home/cltbld', 08:32:30 INFO - 'LANG': 'en_US.UTF-8', 08:32:30 INFO - 'LANGUAGE': 'en_US:en', 08:32:30 INFO - 'LOGNAME': 'cltbld', 08:32:30 INFO - 'MAIL': '/var/mail/cltbld', 08:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:30 INFO - 'MOZ_NO_REMOTE': '1', 08:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:30 INFO - 'NO_EM_RESTART': '1', 08:32:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:30 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:32:30 INFO - 'SHELL': '/bin/bash', 08:32:30 INFO - 'SHLVL': '1', 08:32:30 INFO - 'TERM': 'linux', 08:32:30 INFO - 'TMOUT': '86400', 08:32:30 INFO - 'USER': 'cltbld', 08:32:30 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302', 08:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:30 INFO - '_': '/tools/buildbot/bin/python'} 08:32:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 08:32:30 INFO - mozversion INFO | application_buildid: 20151217053002 08:32:30 INFO - mozversion INFO | application_changeset: cac1c9da152be905dc1cb31fcc33a2cad12fceb5 08:32:30 INFO - mozversion INFO | application_display_name: Nightly 08:32:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:30 INFO - mozversion INFO | application_name: Firefox 08:32:30 INFO - mozversion INFO | application_remotingname: firefox 08:32:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:32:30 INFO - mozversion INFO | application_vendor: Mozilla 08:32:30 INFO - mozversion INFO | application_version: 46.0a1 08:32:30 INFO - mozversion INFO | platform_buildid: 20151217053002 08:32:30 INFO - mozversion INFO | platform_changeset: cac1c9da152be905dc1cb31fcc33a2cad12fceb5 08:32:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:32:30 INFO - mozversion INFO | platform_version: 46.0a1 08:32:30 INFO - 2015-12-17 08:32:30,748 DEBUG : using testdate: 1450369950 08:32:30 INFO - 2015-12-17 08:32:30,748 DEBUG : actual date: 1450369950 08:32:30 INFO - 2015-12-17 08:32:30,761 INFO : starting webserver on 'localhost:52390' 08:32:30 INFO - 2015-12-17 08:32:30,762 INFO : Starting test suite talos-linux64-ix-047 08:32:30 INFO - 2015-12-17 08:32:30,762 INFO : Starting test dromaeo_css 08:32:30 INFO - 2015-12-17 08:32:30,762 DEBUG : operating with platform_type : linux_ 08:32:30 INFO - 2015-12-17 08:32:30,763 INFO : Initialising browser for dromaeo_css test... 08:32:30 INFO - 2015-12-17 08:32:30,777 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYNuTX_/profile http://localhost:52390/getInfo.html 08:32:34 INFO - 2015-12-17 08:32:34,940 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:32:34 INFO - 2015-12-17 08:32:34,941 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:32:34 INFO - 2015-12-17 08:32:34,941 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:32:34 INFO - 2015-12-17 08:32:34,941 DEBUG : BROWSER_OUTPUT: __metrics 08:32:35 INFO - 2015-12-17 08:32:35,029 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:32:35 INFO - 2015-12-17 08:32:35,085 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:35 INFO - 2015-12-17 08:32:35,846 INFO : Browser initialized. 08:32:35 INFO - 2015-12-17 08:32:35,846 INFO : Running cycle 1/1 for dromaeo_css test... 08:32:35 INFO - 2015-12-17 08:32:35,847 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYNuTX_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:32:47 INFO - 2015-12-17 08:32:47,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 149430272 08:32:47 INFO - 2015-12-17 08:32:47,579 DEBUG : BROWSER_OUTPUT: 08:33:39 INFO - 2015-12-17 08:33:39,232 DEBUG : BROWSER_OUTPUT: 1450370019231 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] 08:35:47 INFO - 2015-12-17 08:35:47,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52390/tests/dromaeo/cssquery-ext.html) 08:35:49 INFO - 2015-12-17 08:35:49,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 277524480 08:35:49 INFO - 2015-12-17 08:35:49,158 DEBUG : BROWSER_OUTPUT: 08:38:51 INFO - 2015-12-17 08:38:51,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/dromaeo/cssquery-ext.html (next: http://localhost:52390/tests/dromaeo/cssquery-jquery.html) 08:38:52 INFO - 2015-12-17 08:38:52,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 237383680 08:38:52 INFO - 2015-12-17 08:38:52,051 DEBUG : BROWSER_OUTPUT: 08:41:53 INFO - 2015-12-17 08:41:53,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52390/tests/dromaeo/cssquery-mootools.html) 08:41:54 INFO - 2015-12-17 08:41:54,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 218812416 08:41:54 INFO - 2015-12-17 08:41:54,472 DEBUG : BROWSER_OUTPUT: 08:44:56 INFO - 2015-12-17 08:44:56,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52390/tests/dromaeo/cssquery-prototype.html) 08:44:56 INFO - 2015-12-17 08:44:56,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 209604608 08:44:56 INFO - 2015-12-17 08:44:56,893 DEBUG : BROWSER_OUTPUT: 08:47:59 INFO - 2015-12-17 08:47:59,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52390/tests/dromaeo/cssquery-yui.html) 08:47:59 INFO - 2015-12-17 08:47:59,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 214888448 08:47:59 INFO - 2015-12-17 08:47:59,987 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/dromaeo/cssquery-yui.html (next: http://localhost:52390/tests/dromaeo/cssquery-dojo.html) 08:51:02 INFO - 2015-12-17 08:51:02,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 297197568 08:51:02 INFO - 2015-12-17 08:51:02,769 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,769 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:51:02 INFO - 2015-12-17 08:51:02,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:51:02 INFO - 2015-12-17 08:51:02,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:51:02 INFO - 2015-12-17 08:51:02,770 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:51:02 INFO - 2015-12-17 08:51:02,770 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3171.8572664230114;3204.47126224173;3261.9673803261976;3262.820544870033;3286.2770190558076;5175.689458632475;5260.263563101169;5368.087425137726;5409.729513524323;5461.262729531517;5294.470552944704;5397.163439666848;5409.810656627019;5421.484958928895;5444.183372494128;4890.584300334476;4944.480829512903;4960.528749768766;4964;5014.373203349582;4748.3827102476625;4962.702237865721;4988.975055124719;5016.072026675059;5043.924341134868;4766.499517550659;4775.617950563981;4886.53577910098;4889.779959901813;4902.460729319772;4859.125357435661;4890.217565189552;4904.092742842586;4908.779104940286;4945.381827271591;4703.082898834728;4849.272609108627;4870.220764677634;4873.8781530461665;4933.506649335073;5066.569341605931;5147.562457191143;5153.020926024081;5189.7405129743365;5192.065428222918;5710.200571919934;5711.8000869969765;5713.171590119409;5718.399568045337;5719.942800572025;5742.770289188427;5747.568932330092;5787.33445653751;5798.594098413113;5800.651960882361;5258.947410525922;5322.92015619766;5335.226392173113;5354.866128346823;5358.089124848785;5873.676947767828;5879.706014699248;5882.147088672119;5888.440598143169;5932.2584676915385;5695;5706.229658996065;5707.543396528268;5709.400512946081;5759.22250496186;5663.716814159358;5789.942100579025;5844.88310233793;5869.501092407193;5914.58597898143;5817.592768506164;5818.040023396177;5851.151583020438;5861.238039054895;5861.35525092248;5719.113537401709;5834.737436815353;5835.474807267281;5838.416158384212;5838.941610583925;4408.9559104408545;4440.444944381952;4451.844185453494;4500.122476117126;4506.977465112654;3968.5634580196156;3978.2407269032215;3992.441058251847;4000.6399424051974;4014.578469260744;5519;5525.475079867406;5527.723613819293;5527.917081243784;5580.525655319262;5650.858728531737;5737.397573254748;5796.8550786229835;5805.88388232233;5860.912086318709;5482.342118945672;5508.366537848118;5526.392096869341;5527.060399732055;5532.861678458071;5026;5044.571211447068;5044.924326135111;5050.3939527256225;5093.057784309841;5844.912326315109;5975.372585878507;5975.43233392827;6012.7895523657335;6106.224627875458;5775.249217601685;5785.132230165509;5796.739146738322;5845.561582881216;5853.326867410132;6008.7296071676;6010.278766548042;6013.398660133952;6016.699165041818;6026.0659597762415;5715.885682286248;5768.307803063659;5785.450382213683;5826.941730582809;5906.557008224487;5858.062709966385;5887.470127688357;5899.882002359843;5903.763849446146;5906.084556893688;5731.770729170787;5746.138079287973;5749.080147176432;5750.6837123958585;5755.309362876482;5561.860953476195;5675.602707810413;5677.290338707661;5712.914306285492;5856.824295271149;5634.605577609528;5636.605437619327;5638.126090455986;5639.379668236573;5642.435756424489;5680.318361796611;5683.573731970201;5696.487316141402;5744.798932037359;5746.080627099644;5380.192971054373;5450.890982180414;5471.835844924659;5479.287692599936;5590.105583106846 08:51:02 INFO - 2015-12-17 08:51:02,770 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.5354409384306;610.3560743415696;614.9016157414811;617.3764497857163;618.0266080922547;36358.45462318064;37322.4401633975;37370.43944340837;37399.065023374395;37419.62580374199;41663;42221;42227.36658950118;42261.57738422615;42327.365089523606;7217.278272172794;7284.2351553086955;8638.265747411477;8822.161894620001;9985.90014099857;10180.796384072351;10276.691699248997;10285.331453455501;10311.226658000642;10313.587456501731;10261;10387.220958428148;10388.63639772608;10389;10393.480325983708;7702.653380597886;7863.724769633064;10173.338732982333;10391.688249352455;10393.90863959281;9846.60613575456;10034.046765557261;10046.146077583415;10050.748731281703;10058.899411005943;38510.80744596287;38901.61098389008;39064.414033789515;39075.218495630215;39235.21529569421;3003.8648260828313;3008.337621205227;3052.3895220955897;3067.3251884585356;3694.963050369489;29719.95980140706;29733.10800675983;31906.840465797755;31961.200969975704;32176.356472870644;3913.7064720146104;3927.8428862845453;3936.547297060846;3966.682665386791;4031.2743706132883;250160;252166;252353.73823130951;253298;253813;50972.235416468786;51446.485535144915;58312;58749;58779;69605;70790.2920970794;70906;70995;71079.64460177666;13866.237356945465;14016.929915350358;14072.788908166385;14072.929635351758;14174.220417877115;10484.475776211159;10506.632267870587;10579.153667706565;10591.523381447852;10597.682069537927;19820.504487387643;20193.293234736713;20240.19039238414;20268.797312026985;20293.594128117355;8030.678772849021;8115.837683246302;8134.918650813534;8231.34149268069;8279.50322980623;886.9157430044136;903.5256490342491;973.9902600974041;1021.9029192226726;1028.7993841201044;31835.363292734015;32632.347353052806;32743;32982.340353192805;33138.66861331404;958.0371726414909;973.6689525561343;1001.47923079998;1028.3932479836783;1092.5684354679856;13944;13967.720645587031;14007.159570425807;14217.43130274798;14260.786088208684;354310;354640;356515;357795;359816;50054.74972625114;50318;50337.74831125821;50390.49609503858;50493;1297.3253907967992;1304.373900527752;1321.8612045735251;1322.4511827591634;1427.222163920645;25249.368765781004;25705.35736606525;26486.867565662047;30296.5455518163;31539.52690709687;47570.52429475661;47719;48065.75967120142;48136.518634813205;48137;278547;279652;280496;281109;281443;30950.845245773628;44471.55528444803;44572;44745.77627111843;45845.54154458413;41981.160376792905;42042.789786050875;42132.57867421286;42310.78844605757;42871;34869.1282717924;34981.12547186341;35051.64948350586;35829.82085089662;36184;31060;34759.82620086883;35297.64702352943;36863.81568092143;38158.47366105325;33346.33307333888;34234.82882585571;34446;34546;34557.308853823284;28847;30147.547786782776;31153.844230779607;32063.839680801448;32192.517112243804;25985.6102158464;27319.453610928067;27322.726772732814;27356.452870942867;27415.451690966467 08:51:02 INFO - 2015-12-17 08:51:02,770 DEBUG : BROWSER_OUTPUT: |2;jquery.html;343.63746247708673;353.99999999999994;354.69319039031234;355.1529601899469;355.8896742009977;14261.857381426182;14307.570772876805;16866.409675661354;17372.73940890886;18393.908030459846;12138.939305303462;12665.113442059059;14497.49258775943;14820.258987050658;14830.925845370784;5007.298978143072;5122.359705036871;5124.641275110744;5129;5129.717865517395;3726.4596633488127;3836.2327534493074;5075.949240507584;5086.237064440345;5107.438181799999;5480.3971563128025;5648.774049038034;5673.489385955263;5673.773049078052;5676.3188417389765;5549.972250138764;5631;5647.491725744682;6121.449069583714;6154.292256390483;5446.564274858002;5451.918221226685;5453.972730136364;5472.151816468454;5477.4796394342475;13107.410166542528;13216.537421190309;13247.66880827987;13281.468741250339;18476.98376589287;1933.419974007792;2086.7078608994752;2206.5917805206086;2216.5345277491747;2248.022110381989;9139.588718507683;9178.724638260863;9416.576254068583;9515.23878089751;9570.712878613653;1755.139981409113;1779.217144456435;1810.8913465192;1818.8817726847712;1839.0712690091418;57899;59883.40116598865;60755;60845.695771520855;61099.38900610981;9216.124468175512;9259.120383563552;9718.562664680107;9761.755956101155;9772.804543909224;11714.941425292818;11777.352245626573;11787.528498859949;11830.704232394259;11836.349000805038;7030.402415794715;7040;7050.224475307815;7111.751088711871;7114.964425177841;6860.416864566468;6871.553349032297;6899.068625735462;6913.861722765517;6939.826504337331;4179.2895207814745;4210.536840947493;4263.4031235627035;4304.4834619845815;4477.261251893401;1644.136828165199;1701.574606348413;1738.2438639191992;1750.3523696232476;1754.596442818159;417.0678533477675;418.3452896217471;881.8280435315052;966.9750064931195;986.6990567876867;9925.553350099262;10186.694399168036;10417.322874013165;10498.10766084876;10504.684859454228;388.2080555666409;434.5676052327954;441.4900789588031;452.3057107340217;461.8822200338892;5608.130739735348;5797.304323481209;5834.183214349994;5934.495567876779;5960.105984102419;529030;540019;546088;546488;551346;77806;78607.21392786;79379.60310198528;80186;80190.59904700555;486.11284405959265;487.9609631229493;488.7727206848904;490.16671658181235;490.5952589113995;9881.950590247003;9997.100260976547;10005.699829005142;10117;10190.286679932333;32921.34157316888;33254.66745332516;33261.33477330488;33324.33351332911;34166.82916585401;47443.288350674076;47936.5206347932;48035;48096;49649.75175124101;9119.179273865384;9149.679761208326;9290.767730806783;9292.070792920655;9451.102145296185;11335.319880807177;15315.61710957235;16423.507294781175;17276.74084888753;17416.390426335016;14521.128732276096;14539.85460145385;14847.183404912834;14865.182414966848;14900.701985960004;14432.494862679756;14506.419743210154;14532.128072315694;14771.409143634135;14890.702185956437;12313.56902508408;14862.479813206486;15127.470538531099;15158.16630085356;15315.617109571904;8369.288610467935;8880.73357799267;8995.190432861074;9007.954960225157;9092.363534552782;13126.40931158081;13954.116194313638;14006.159630422208;14068.437262509386;14528.927355363156 08:51:02 INFO - 2015-12-17 08:51:02,770 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1340.9396577154039;1443.213448670475;1500.6398464368551;1608.8069431668202;1776.0941919620998;6911.447084233262;7610.619469026554;7776.18350073242;7787.182345853689;7791.883121753164;7472.476926615139;7625;7636.88544671829;7638.847223055535;7643.082830060386;1983.990080049605;2024.2712623455545;2259.3109101723967;2282.7032485776867;2312.109837712476;2278.327893271489;2282.7032485776826;2286.5655525450193;2287.885605719716;2289.9885500572473;2203.504211552404;2293.552757212344;2297.4026753044245;2299.9540009199804;2300.7584203658625;2296.954060918789;2304.8617082974993;2309.7690230976937;2310.8151347892126;2313.849599776009;2285.3372521968777;2306.077568972408;2325.767423257678;2341.2156927429332;2342.426105604121;7556.584387858666;7614.695412183506;7619.657115429819;7620.771376858703;7623.2376762323875;4632.0967411354795;4732.716037037789;4734.786934587952;4738.739369334685;4740.407449068866;3048.832314222717;3114.019083988559;3135.372925414926;3191.5850939377733;3229.7093261606333;972.9221662267001;976.4922240434934;997.8952210017989;1027.126942099217;1053.5364439646607;10424.061834434862;10426.061654451136;10457;10467.738306542398;10475.47622618866;4375.803088861009;4417.3815665806815;4431.8448854289945;4479.417675702138;4500.189965806187;9016.684416045538;9025.684101056431;9027.954860225656;9034.32242581809;9057.365984381162;4718.197906355927;4719.740414277179;4733.313669517969;4742.288656701522;4746.928796068062;4214.009707718684;4269.850555230552;4284.635805956528;4292.720973136736;4305.698601097955;3192.553042573995;3196.184972831913;3265.4775235962134;3292.93414131716;3609.9639003609627;1196.9281843089443;1213.6783752305646;1216.0818581970555;1219.40249277855;1221.3099598726692;982.219135787051;986.329296078659;1051.148569658579;1054.9450549450548;1193.3734789235548;7314.122305323289;7374.705011799575;7383.81540461482;7392.852142957111;7398.186199518049;1099.3623698254994;1108.8669359676728;1112.8052590796578;1114.0920150077661;1114.1421105748527;5636.830895073154;5719.2279042328755;5749.798757043483;5756.856078598069;5763.308402991668;8746.169113934166;9212.170904618617;9228.676996305232;9236.953815230881;9251.49116798569;8982.101789820965;9021;9050.773730656654;9056.818863622691;9062.139096785795;6760.594364338155;6991.23096459389;7045.753398631024;7050.858982820315;7093.82265443368;7157.749478768218;7161.892571611325;7171.533850299714;7215.530990485601;7215.963920180366;7745.109312429143;7989;8084.191580842104;8174.346052315919;8187.3040791531;8055.436119471581;8203.83592328162;8207.507549547046;8218.260356567938;8246.340292776684;6743.431642027508;6823.385895269251;6953.548019378724;6965.965170174117;6979.755708550177;6357.8728425432155;6567.31043240472;6806.76176333826;6996.895046574204;7552.093748750185;6888;6992.16094068715;7054.964725176341;7109.075820143348;7144.67848946809;6827.180738311435;6914.239433662394;6984.511084224056;7083.858322833411;7119.9644001781735;7019.6841142147705;7062.0466237057335;7068.081149450744;7075.433965282662;7076.823079423056;6500.674966251574;6522.543421960418;6535.738570457129;6555.672216389066;6577.736890524326;6495.902561461677;6525.184351956005;6536.869262614816;6542.378474044958;6547.377999090078 08:51:02 INFO - 2015-12-17 08:51:02,770 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.7222477568394;345.94118999770035;348.28427581320386;352.8412214503474;356.8947160587628;5904.6457212567275;5917.763289468421;6036.396360363967;6047.274327080745;6071.423214794588;5778.0466223073245;5917.911231331534;5950.940490595092;5965.522758179346;5974.283086029672;4611.584957353846;4619.838305659303;4624.583787459128;4627.051454451829;4631.374764406795;4408.20652282589;4463.598276155145;4561.247394179956;4604.447466304048;4624.213883639789;4499.595036446719;4502.954970450286;4503.166914120881;4524.434445694288;4578.816847326103;4513.119941611387;4556.77216139195;4577.130345234428;4587.3807036050375;4611.4005179326805;4079.0822065035427;4081.3061779497557;4084.4690190275073;4086.856960006415;4088.632023117934;5552.333719953632;5670.404607516192;5676.716164191816;5692.430756924316;5713.942860571383;5343.278657381243;5343.946560534384;5348.251244825728;5348.502419322596;5359.866003349947;6060.818175454743;6376.075469056961;6387.808365749035;6392.689498652765;6400.263969643457;4277.230098582254;4327.06968001878;4408.669349798778;4446.444194475691;4447.266201076818;6507.44686701631;6588.670566471657;6608.702608382586;6613.371729685672;6622.238442579117;4521.660875434355;4538.364628951949;4542.931856022163;4544.068465964469;4547.3179023146795;4501.7524036177665;4586.495485496593;4592.586667199968;4600.42494688164;4616.953830461653;5297.708626025528;5301.443348448434;5307.840764777063;5315;5315.495027972336;6397.424231819065;6401.3278605746655;6404.839879002969;6406.135171751847;6409.551331406757;1602.1268408717276;1607.6382813866787;1608.0271435781417;1608.6300150965344;1610.7825443565202;1058.2116323339162;1061.639042725477;1066.0618655583191;1071.978560428787;1091.1761619976867;6219.875602488016;6244.46922011625;6260.092286618415;6263.404976527223;6266.122742816009;6623.635700036448;6624.8012559623285;6626.608412233485;6631.701573429207;6661.600303981777;5986;6152.446279834837;6161.44546990773;6162.784302549389;6165.290991535941;3586.6592673696478;3599.9280014399565;3606.9179246226026;3611.1513794258326;3623.0942264433893;6770.69531871067;6774.424173945171;6778.457723382117;6786.660666966632;6790.694418751168;6652.467802575782;6758.93241067583;6767;6790.151231096113;6792.864142717118;6843.349881761224;6845.691943862538;6854.0404343391965;6862.073620061228;6873.037774711544;6434.06706027614;6624.403803657694;6626.4367528760595;6629.502787290876;6642.933570664231;6448.387403196689;6486.805395838132;6493.805185844432;6494.642794646151;6577.835554110994;6914.0320355151325;6917.584944903322;6921.89617155733;6931.930680693128;6934.791956241119;4438.267685831931;4537.773111344485;4542.613877820422;4543.159515489645;4547.795349209359;6645.60126392418;6670.966645166744;6681.832954176184;6684.933150668431;6690.632015239208;6443.6133831968355;6471.25580558223;6473.482121430368;6492.675366231764;6493.902591461037;6309.968450157719;6469.159009328757;6475.870482590228;6479.254885688206;6534.313897040743;6365.872682546231;6379.202599675041;6388.456981156468;6397.6481293529305;6398.104265402941;6551.246606640298;6553.180852393451;6556.409923106943;6560.573562718408;6564.770233041821;6235.96882015587;6322.083297921868;6325.652089135142;6371.044343348535;6398.360163983564 08:51:02 INFO - 2015-12-17 08:51:02,771 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.861872282717;758.4577027425391;767.8234006178578;774.8527779721849;844.6790219716506;12549.560765373202;12998.15511991721;13007.674808129801;13021.28382938938;13045.021623378248;13293.534726284583;13391.598252052454;13392.397342119604;13401.195928244311;13412.26232557209;683.5966779600035;696.5785699651714;698.7030512032392;838.2748922182315;854.6068808348167;694.0422217340089;832.5545832979358;850.4344610833788;851.748734123435;854.7521218846528;887.1926546842375;887.9822403551925;893.7497500699782;893.9240164585985;894.217559635319;705.9117610298713;881.3918396306592;884.1114679746845;884.1158841158841;887.7691800131947;528.632600342762;631.1668597451365;644.7292137302297;647.0520687193238;648.3937518420292;12765.872341276561;12952.093353465261;13062.346882655924;13079.86920130796;13088.149270297401;12199.390030498529;12627.368631568384;12692.30192339421;12789.936050319782;13167.934160329138;10048.69853904384;10190.541425635864;10250.589976400935;10277.48612569376;10595.629152979685;3625.474306225609;3637.7089832813313;3665.651763082503;3692.7599706019023;3763.360228761117;42500.57499424997;42758.78620606908;42788.57211427877;42956.57043429557;43230.35154472717;9685.806283874283;9816.165625921734;9903.158231550398;9903.356281841658;10080.445575493419;17328.220230089675;17332.740008899877;17355.65288694219;17368.4789456314;17372;7383.114026316876;7542;7551.848963020709;7586.658600362997;7772.65023073963;4385.780710964503;4398.23030969579;4408.713433626868;4409.162259170811;4426.313921342197;3175.587173667455;3190.744740420761;3209.021248519224;3209.422303985305;3214.244652506659;573.3578392200678;578.8784355285437;595.5503594785908;596.5138412194048;605.1890466774455;486.8515102893581;509.80882169186555;520.1495554767981;536.7584586935816;547.2065505017661;8965.462072275684;9265.305102117369;9420.905790942003;9731.56207970643;9815.852762208573;594.180031556458;598.6557729305666;672.9226138994078;694.9965250173818;710.3571268002466;3919.6864250859862;4034.6570541503716;4051.2707712612014;4071.959280407217;4142.46148000764;55896.44103558912;61505.38494615086;61998;62007.68996155081;62280.377196228364;50780.746096269286;51129.48870511322;52458;52508.212376813615;53218;47075.52924470711;47293.76353118212;47899.5210047902;48264.75867620709;48457;8459.703910363107;8616.741497755078;8648.1784230498;8813.42712723671;8817.911820881709;35094.29811403707;35376.29247415089;35452.64547354596;36019;36076;46426.535734642224;46514.76742616265;47181.528184719085;47289.763551182026;47919.52080479151;10622.681319560426;10850.565977360817;10936;11059.778804424028;11137.431284357821;12420.254784712946;12474.376281186085;12600.959675736938;12689.682757931125;12731.681707957376;11161.330320180816;11513.366764828015;11554.653360399201;11816.704582385166;11903.940480297542;11539.538418463504;11720.413979301171;11879.881201187878;12181.69545761363;12220.938895305466;11242.887571124184;11286.379249141377;11461.828072579085;11572.768544628892;11687.39802715306;9174.934621603945;9279.285979918186;9304.82293691556;9304.934404828657;9539.57071931751;8850.336224783296;8965.731028069169;9596.18432433251;9795.314327997257;9967.800643986935 08:51:02 INFO - 2015-12-17 08:51:02,771 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,975 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371062762__endTimestamp 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5381.89 Median:5636.61 stddev:605.41 (10.7%) stddev-sans-first:581.91 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: Values: 3171.9 3204.5 3262.0 3262.8 3286.3 5175.7 5260.3 5368.1 5409.7 5461.3 5294.5 5397.2 5409.8 5421.5 5444.2 4890.6 4944.5 4960.5 4964.0 5014.4 4748.4 4962.7 4989.0 5016.1 5043.9 4766.5 4775.6 4886.5 4889.8 4902.5 4859.1 4890.2 4904.1 4908.8 4945.4 4703.1 4849.3 4870.2 4873.9 4933.5 5066.6 5147.6 5153.0 5189.7 5192.1 5710.2 5711.8 5713.2 5718.4 5719.9 5742.8 5747.6 5787.3 5798.6 5800.7 5258.9 5322.9 5335.2 5354.9 5358.1 5873.7 5879.7 5882.1 5888.4 5932.3 5695.0 5706.2 5707.5 5709.4 5759.2 5663.7 5789.9 5844.9 5869.5 5914.6 5817.6 5818.0 5851.2 5861.2 5861.4 5719.1 5834.7 5835.5 5838.4 5838.9 4409.0 4440.4 4451.8 4500.1 4507.0 3968.6 3978.2 3992.4 4000.6 4014.6 5519.0 5525.5 5527.7 5527.9 5580.5 5650.9 5737.4 5796.9 5805.9 5860.9 5482.3 5508.4 5526.4 5527.1 5532.9 5026.0 5044.6 5044.9 5050.4 5093.1 5844.9 5975.4 5975.4 6012.8 6106.2 5775.2 5785.1 5796.7 5845.6 5853.3 6008.7 6010.3 6013.4 6016.7 6026.1 5715.9 5768.3 5785.5 5826.9 5906.6 5858.1 5887.5 5899.9 5903.8 5906.1 5731.8 5746.1 5749.1 5750.7 5755.3 5561.9 5675.6 5677.3 5712.9 5856.8 5634.6 5636.6 5638.1 5639.4 5642.4 5680.3 5683.6 5696.5 5744.8 5746.1 5380.2 5450.9 5471.8 5479.3 5590.1 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,772 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47145.49 Median:34496.00 stddev:78436.33 (227.4%) stddev-sans-first:78578.39 08:51:02 INFO - 2015-12-17 08:51:02,774 DEBUG : BROWSER_OUTPUT: Values: 566.5 610.4 614.9 617.4 618.0 36358.5 37322.4 37370.4 37399.1 37419.6 41663.0 42221.0 42227.4 42261.6 42327.4 7217.3 7284.2 8638.3 8822.2 9985.9 10180.8 10276.7 10285.3 10311.2 10313.6 10261.0 10387.2 10388.6 10389.0 10393.5 7702.7 7863.7 10173.3 10391.7 10393.9 9846.6 10034.0 10046.1 10050.7 10058.9 38510.8 38901.6 39064.4 39075.2 39235.2 3003.9 3008.3 3052.4 3067.3 3695.0 29720.0 29733.1 31906.8 31961.2 32176.4 3913.7 3927.8 3936.5 3966.7 4031.3 250160.0 252166.0 252353.7 253298.0 253813.0 50972.2 51446.5 58312.0 58749.0 58779.0 69605.0 70790.3 70906.0 70995.0 71079.6 13866.2 14016.9 14072.8 14072.9 14174.2 10484.5 10506.6 10579.2 10591.5 10597.7 19820.5 20193.3 20240.2 20268.8 20293.6 8030.7 8115.8 8134.9 8231.3 8279.5 886.9 903.5 974.0 1021.9 1028.8 31835.4 32632.3 32743.0 32982.3 33138.7 958.0 973.7 1001.5 1028.4 1092.6 13944.0 13967.7 14007.2 14217.4 14260.8 354310.0 354640.0 356515.0 357795.0 359816.0 50054.7 50318.0 50337.7 50390.5 50493.0 1297.3 1304.4 1321.9 1322.5 1427.2 25249.4 25705.4 26486.9 30296.5 31539.5 47570.5 47719.0 48065.8 48136.5 48137.0 278547.0 279652.0 280496.0 281109.0 281443.0 30950.8 44471.6 44572.0 44745.8 45845.5 41981.2 42042.8 42132.6 42310.8 42871.0 34869.1 34981.1 35051.6 35829.8 36184.0 31060.0 34759.8 35297.6 36863.8 38158.5 33346.3 34234.8 34446.0 34546.0 34557.3 28847.0 30147.5 31153.8 32063.8 32192.5 25985.6 27319.5 27322.7 27356.5 27415.5 08:51:02 INFO - 2015-12-17 08:51:02,774 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,774 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28020.82 Median:23952.59 stddev:88797.14 (370.7%) stddev-sans-first:89021.92 08:51:02 INFO - 2015-12-17 08:51:02,774 DEBUG : BROWSER_OUTPUT: Values: 343.6 354.0 354.7 355.2 355.9 14261.9 14307.6 16866.4 17372.7 18393.9 12138.9 12665.1 14497.5 14820.3 14830.9 5007.3 5122.4 5124.6 5129.0 5129.7 3726.5 3836.2 5075.9 5086.2 5107.4 5480.4 5648.8 5673.5 5673.8 5676.3 5550.0 5631.0 5647.5 6121.4 6154.3 5446.6 5451.9 5454.0 5472.2 5477.5 13107.4 13216.5 13247.7 13281.5 18477.0 1933.4 2086.7 2206.6 2216.5 2248.0 9139.6 9178.7 9416.6 9515.2 9570.7 1755.1 1779.2 1810.9 1818.9 1839.1 57899.0 59883.4 60755.0 60845.7 61099.4 9216.1 9259.1 9718.6 9761.8 9772.8 11714.9 11777.4 11787.5 11830.7 11836.3 7030.4 7040.0 7050.2 7111.8 7115.0 6860.4 6871.6 6899.1 6913.9 6939.8 4179.3 4210.5 4263.4 4304.5 4477.3 1644.1 1701.6 1738.2 1750.4 1754.6 417.1 418.3 881.8 967.0 986.7 9925.6 10186.7 10417.3 10498.1 10504.7 388.2 434.6 441.5 452.3 461.9 5608.1 5797.3 5834.2 5934.5 5960.1 529030.0 540019.0 546088.0 546488.0 551346.0 77806.0 78607.2 79379.6 80186.0 80190.6 486.1 488.0 488.8 490.2 490.6 9882.0 9997.1 10005.7 10117.0 10190.3 32921.3 33254.7 33261.3 33324.3 34166.8 47443.3 47936.5 48035.0 48096.0 49649.8 9119.2 9149.7 9290.8 9292.1 9451.1 11335.3 15315.6 16423.5 17276.7 17416.4 14521.1 14539.9 14847.2 14865.2 14900.7 14432.5 14506.4 14532.1 14771.4 14890.7 12313.6 14862.5 15127.5 15158.2 15315.6 8369.3 8880.7 8995.2 9008.0 9092.4 13126.4 13954.1 14006.2 14068.4 14528.9 08:51:02 INFO - 2015-12-17 08:51:02,774 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,774 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5381.40 Median:6536.30 stddev:2749.47 (42.1%) stddev-sans-first:2740.40 08:51:02 INFO - 2015-12-17 08:51:02,775 DEBUG : BROWSER_OUTPUT: Values: 1340.9 1443.2 1500.6 1608.8 1776.1 6911.4 7610.6 7776.2 7787.2 7791.9 7472.5 7625.0 7636.9 7638.8 7643.1 1984.0 2024.3 2259.3 2282.7 2312.1 2278.3 2282.7 2286.6 2287.9 2290.0 2203.5 2293.6 2297.4 2300.0 2300.8 2297.0 2304.9 2309.8 2310.8 2313.8 2285.3 2306.1 2325.8 2341.2 2342.4 7556.6 7614.7 7619.7 7620.8 7623.2 4632.1 4732.7 4734.8 4738.7 4740.4 3048.8 3114.0 3135.4 3191.6 3229.7 972.9 976.5 997.9 1027.1 1053.5 10424.1 10426.1 10457.0 10467.7 10475.5 4375.8 4417.4 4431.8 4479.4 4500.2 9016.7 9025.7 9028.0 9034.3 9057.4 4718.2 4719.7 4733.3 4742.3 4746.9 4214.0 4269.9 4284.6 4292.7 4305.7 3192.6 3196.2 3265.5 3292.9 3610.0 1196.9 1213.7 1216.1 1219.4 1221.3 982.2 986.3 1051.1 1054.9 1193.4 7314.1 7374.7 7383.8 7392.9 7398.2 1099.4 1108.9 1112.8 1114.1 1114.1 5636.8 5719.2 5749.8 5756.9 5763.3 8746.2 9212.2 9228.7 9237.0 9251.5 8982.1 9021.0 9050.8 9056.8 9062.1 6760.6 6991.2 7045.8 7050.9 7093.8 7157.7 7161.9 7171.5 7215.5 7216.0 7745.1 7989.0 8084.2 8174.3 8187.3 8055.4 8203.8 8207.5 8218.3 8246.3 6743.4 6823.4 6953.5 6966.0 6979.8 6357.9 6567.3 6806.8 6996.9 7552.1 6888.0 6992.2 7055.0 7109.1 7144.7 6827.2 6914.2 6984.5 7083.9 7120.0 7019.7 7062.0 7068.1 7075.4 7076.8 6500.7 6522.5 6535.7 6555.7 6577.7 6495.9 6525.2 6536.9 6542.4 6547.4 08:51:02 INFO - 2015-12-17 08:51:02,776 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,776 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5356.12 Median:6066.12 stddev:1622.73 (26.8%) stddev-sans-first:1582.98 08:51:02 INFO - 2015-12-17 08:51:02,777 DEBUG : BROWSER_OUTPUT: Values: 338.7 345.9 348.3 352.8 356.9 5904.6 5917.8 6036.4 6047.3 6071.4 5778.0 5917.9 5950.9 5965.5 5974.3 4611.6 4619.8 4624.6 4627.1 4631.4 4408.2 4463.6 4561.2 4604.4 4624.2 4499.6 4503.0 4503.2 4524.4 4578.8 4513.1 4556.8 4577.1 4587.4 4611.4 4079.1 4081.3 4084.5 4086.9 4088.6 5552.3 5670.4 5676.7 5692.4 5713.9 5343.3 5343.9 5348.3 5348.5 5359.9 6060.8 6376.1 6387.8 6392.7 6400.3 4277.2 4327.1 4408.7 4446.4 4447.3 6507.4 6588.7 6608.7 6613.4 6622.2 4521.7 4538.4 4542.9 4544.1 4547.3 4501.8 4586.5 4592.6 4600.4 4617.0 5297.7 5301.4 5307.8 5315.0 5315.5 6397.4 6401.3 6404.8 6406.1 6409.6 1602.1 1607.6 1608.0 1608.6 1610.8 1058.2 1061.6 1066.1 1072.0 1091.2 6219.9 6244.5 6260.1 6263.4 6266.1 6623.6 6624.8 6626.6 6631.7 6661.6 5986.0 6152.4 6161.4 6162.8 6165.3 3586.7 3599.9 3606.9 3611.2 3623.1 6770.7 6774.4 6778.5 6786.7 6790.7 6652.5 6758.9 6767.0 6790.2 6792.9 6843.3 6845.7 6854.0 6862.1 6873.0 6434.1 6624.4 6626.4 6629.5 6642.9 6448.4 6486.8 6493.8 6494.6 6577.8 6914.0 6917.6 6921.9 6931.9 6934.8 4438.3 4537.8 4542.6 4543.2 4547.8 6645.6 6671.0 6681.8 6684.9 6690.6 6443.6 6471.3 6473.5 6492.7 6493.9 6310.0 6469.2 6475.9 6479.3 6534.3 6365.9 6379.2 6388.5 6397.6 6398.1 6551.2 6553.2 6556.4 6560.6 6564.8 6236.0 6322.1 6325.7 6371.0 6398.4 08:51:02 INFO - 2015-12-17 08:51:02,777 DEBUG : BROWSER_OUTPUT: 08:51:02 INFO - 2015-12-17 08:51:02,777 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13895.84 Median:47291.76 stddev:16188.55 (34.2%) stddev-sans-first:16203.88 08:51:02 INFO - 2015-12-17 08:51:02,777 DEBUG : BROWSER_OUTPUT: Values: 752.9 758.5 767.8 774.9 844.7 12549.6 12998.2 13007.7 13021.3 13045.0 13293.5 13391.6 13392.4 13401.2 13412.3 683.6 696.6 698.7 838.3 854.6 694.0 832.6 850.4 851.7 854.8 887.2 888.0 893.7 893.9 894.2 705.9 881.4 884.1 884.1 887.8 528.6 631.2 644.7 647.1 648.4 12765.9 12952.1 13062.3 13079.9 13088.1 12199.4 12627.4 12692.3 12789.9 13167.9 10048.7 10190.5 10250.6 10277.5 10595.6 3625.5 3637.7 3665.7 3692.8 3763.4 42500.6 42758.8 42788.6 42956.6 43230.4 9685.8 9816.2 9903.2 9903.4 10080.4 17328.2 17332.7 17355.7 17368.5 17372.0 7383.1 7542.0 7551.8 7586.7 7772.7 4385.8 4398.2 4408.7 4409.2 4426.3 3175.6 3190.7 3209.0 3209.4 3214.2 573.4 578.9 595.6 596.5 605.2 486.9 509.8 520.1 536.8 547.2 8965.5 9265.3 9420.9 9731.6 9815.9 594.2 598.7 672.9 695.0 710.4 3919.7 4034.7 4051.3 4072.0 4142.5 55896.4 61505.4 61998.0 62007.7 62280.4 50780.7 51129.5 52458.0 52508.2 53218.0 47075.5 47293.8 47899.5 48264.8 48457.0 8459.7 8616.7 8648.2 8813.4 8817.9 35094.3 35376.3 35452.6 36019.0 36076.0 46426.5 46514.8 47181.5 47289.8 47919.5 10622.7 10850.6 10936.0 11059.8 11137.4 12420.3 12474.4 12601.0 12689.7 12731.7 11161.3 11513.4 11554.7 11816.7 11903.9 11539.5 11720.4 11879.9 12181.7 12220.9 11242.9 11286.4 11461.8 11572.8 11687.4 9174.9 9279.3 9304.8 9304.9 9539.6 8850.3 8965.7 9596.2 9795.3 9967.8 08:51:02 INFO - 2015-12-17 08:51:02,777 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:51:02 INFO - 2015-12-17 08:51:02,777 DEBUG : BROWSER_OUTPUT: 08:51:03 INFO - 2015-12-17 08:51:03,503 INFO : Browser exited with error code: 0 08:51:03 INFO - 2015-12-17 08:51:03,519 INFO : Completed test dromaeo_css (00:18:32) 08:51:03 INFO - 2015-12-17 08:51:03,519 INFO : Starting test kraken 08:51:03 INFO - 2015-12-17 08:51:03,519 DEBUG : operating with platform_type : linux_ 08:51:03 INFO - 2015-12-17 08:51:03,520 INFO : Initialising browser for kraken test... 08:51:03 INFO - 2015-12-17 08:51:03,526 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy9R0br/profile http://localhost:52390/getInfo.html 08:51:07 INFO - 2015-12-17 08:51:07,230 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:51:07 INFO - 2015-12-17 08:51:07,230 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:51:07 INFO - 2015-12-17 08:51:07,230 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:51:07 INFO - 2015-12-17 08:51:07,230 DEBUG : BROWSER_OUTPUT: __metrics 08:51:07 INFO - 2015-12-17 08:51:07,319 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:51:07 INFO - 2015-12-17 08:51:07,375 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:08 INFO - 2015-12-17 08:51:08,446 INFO : Browser initialized. 08:51:08 INFO - 2015-12-17 08:51:08,447 INFO : Running cycle 1/1 for kraken test... 08:51:08 INFO - 2015-12-17 08:51:08,447 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy9R0br/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:51:20 INFO - 2015-12-17 08:51:20,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 149405696 08:51:20 INFO - 2015-12-17 08:51:20,247 DEBUG : BROWSER_OUTPUT: 08:51:22 INFO - 2015-12-17 08:51:22,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52390/tests/kraken/driver.html?testName=audio-beat-detection) 08:51:23 INFO - 2015-12-17 08:51:23,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 186814464 08:51:23 INFO - 2015-12-17 08:51:23,261 DEBUG : BROWSER_OUTPUT: 08:51:25 INFO - 2015-12-17 08:51:25,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52390/tests/kraken/driver.html?testName=audio-dft) 08:51:26 INFO - 2015-12-17 08:51:26,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 175132672 08:51:26 INFO - 2015-12-17 08:51:26,419 DEBUG : BROWSER_OUTPUT: 08:51:29 INFO - 2015-12-17 08:51:29,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52390/tests/kraken/driver.html?testName=audio-fft) 08:51:29 INFO - 2015-12-17 08:51:29,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 160149504 08:51:29 INFO - 2015-12-17 08:51:29,830 DEBUG : BROWSER_OUTPUT: 08:51:31 INFO - 2015-12-17 08:51:31,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52390/tests/kraken/driver.html?testName=audio-oscillator) 08:51:32 INFO - 2015-12-17 08:51:32,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 162594816 08:51:32 INFO - 2015-12-17 08:51:32,399 DEBUG : BROWSER_OUTPUT: 08:51:34 INFO - 2015-12-17 08:51:34,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:35 INFO - 2015-12-17 08:51:35,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 163422208 08:51:35 INFO - 2015-12-17 08:51:35,166 DEBUG : BROWSER_OUTPUT: 08:51:38 INFO - 2015-12-17 08:51:38,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52390/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:38 INFO - 2015-12-17 08:51:38,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 163590144 08:51:38 INFO - 2015-12-17 08:51:38,678 DEBUG : BROWSER_OUTPUT: 08:51:42 INFO - 2015-12-17 08:51:42,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52390/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:42 INFO - 2015-12-17 08:51:42,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 164519936 08:51:42 INFO - 2015-12-17 08:51:42,584 DEBUG : BROWSER_OUTPUT: 08:51:45 INFO - 2015-12-17 08:51:45,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52390/tests/kraken/driver.html?testName=json-parse-financial) 08:51:45 INFO - 2015-12-17 08:51:45,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 166080512 08:51:45 INFO - 2015-12-17 08:51:45,902 DEBUG : BROWSER_OUTPUT: 08:51:47 INFO - 2015-12-17 08:51:47,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:48 INFO - 2015-12-17 08:51:48,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 173248512 08:51:48 INFO - 2015-12-17 08:51:48,003 DEBUG : BROWSER_OUTPUT: 08:51:49 INFO - 2015-12-17 08:51:49,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:50 INFO - 2015-12-17 08:51:50,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 170348544 08:51:50 INFO - 2015-12-17 08:51:50,401 DEBUG : BROWSER_OUTPUT: 08:51:52 INFO - 2015-12-17 08:51:52,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:53 INFO - 2015-12-17 08:51:53,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 180776960 08:51:53 INFO - 2015-12-17 08:51:53,023 DEBUG : BROWSER_OUTPUT: 08:51:55 INFO - 2015-12-17 08:51:55,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:55 INFO - 2015-12-17 08:51:55,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 192598016 08:51:55 INFO - 2015-12-17 08:51:55,995 DEBUG : BROWSER_OUTPUT: 08:51:58 INFO - 2015-12-17 08:51:58,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:59 INFO - 2015-12-17 08:51:59,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 189468672 08:51:59 INFO - 2015-12-17 08:51:59,115 DEBUG : BROWSER_OUTPUT: 08:52:00 INFO - 2015-12-17 08:52:00,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52390/tests/kraken/driver.html?testName=ai-astar) 08:52:01 INFO - 2015-12-17 08:52:01,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 247762944 08:52:01 INFO - 2015-12-17 08:52:01,047 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,051 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:01 INFO - 2015-12-17 08:52:01,051 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:01 INFO - 2015-12-17 08:52:01,051 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:01 INFO - 2015-12-17 08:52:01,051 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:01 INFO - 2015-12-17 08:52:01,051 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;110;110;110;99;109;110;109 08:52:01 INFO - 2015-12-17 08:52:01,051 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;122;148;158;124;157;146;129;164;130 08:52:01 INFO - 2015-12-17 08:52:01,051 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;159;161;161;159;162;161;160 08:52:01 INFO - 2015-12-17 08:52:01,052 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;84;97;70;71;77;101;93;71 08:52:01 INFO - 2015-12-17 08:52:01,052 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;149;93;93;93;135;92;93;137 08:52:01 INFO - 2015-12-17 08:52:01,052 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;108;109;109;109;110;109 08:52:01 INFO - 2015-12-17 08:52:01,052 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;145;147;145;145;146;145 08:52:01 INFO - 2015-12-17 08:52:01,052 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;95;95;96;95;96;95;95 08:52:01 INFO - 2015-12-17 08:52:01,052 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;57;57;58;58;59;66;55;56 08:52:01 INFO - 2015-12-17 08:52:01,052 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;68;68;68;68;75;68;67;68 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;85;84;85;86;84;85;86 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;123;119;114;124;115;115;123;122;112 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;140;142;149;152;143;151;152;151;150 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;69;67;66;70;67;65;67;67;67 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 08:52:01 INFO - 2015-12-17 08:52:01,053 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:52:01 INFO - 2015-12-17 08:52:01,054 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371121049__endTimestamp 08:52:01 INFO - 2015-12-17 08:52:01,054 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,057 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:01 INFO - 2015-12-17 08:52:01,057 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:52:01 INFO - 2015-12-17 08:52:01,058 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,058 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.73 (3.4%) stddev-sans-first:3.94 08:52:01 INFO - 2015-12-17 08:52:01,058 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 110.0 110.0 110.0 99.0 109.0 110.0 109.0 08:52:01 INFO - 2015-12-17 08:52:01,058 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,058 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.00 stddev:15.32 (10.3%) stddev-sans-first:16.02 08:52:01 INFO - 2015-12-17 08:52:01,058 DEBUG : BROWSER_OUTPUT: Values: 150.0 122.0 148.0 158.0 124.0 157.0 146.0 129.0 164.0 130.0 08:52:01 INFO - 2015-12-17 08:52:01,059 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,059 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 08:52:01 INFO - 2015-12-17 08:52:01,059 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 159.0 161.0 161.0 159.0 162.0 161.0 160.0 08:52:01 INFO - 2015-12-17 08:52:01,060 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,060 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:74.50 stddev:12.14 (16.3%) stddev-sans-first:12.36 08:52:01 INFO - 2015-12-17 08:52:01,061 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 84.0 97.0 70.0 71.0 77.0 101.0 93.0 71.0 08:52:01 INFO - 2015-12-17 08:52:01,061 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,061 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.00 stddev:23.08 (24.8%) stddev-sans-first:23.97 08:52:01 INFO - 2015-12-17 08:52:01,061 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 149.0 93.0 93.0 93.0 135.0 92.0 93.0 137.0 08:52:01 INFO - 2015-12-17 08:52:01,061 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,061 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 08:52:01 INFO - 2015-12-17 08:52:01,062 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 110.0 109.0 08:52:01 INFO - 2015-12-17 08:52:01,062 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,062 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:52:01 INFO - 2015-12-17 08:52:01,062 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 145.0 147.0 145.0 145.0 146.0 145.0 08:52:01 INFO - 2015-12-17 08:52:01,062 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,062 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 08:52:01 INFO - 2015-12-17 08:52:01,062 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:2.99 (5.1%) stddev-sans-first:3.16 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 57.0 57.0 58.0 58.0 59.0 66.0 55.0 56.0 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:2.32 (3.4%) stddev-sans-first:2.46 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 68.0 68.0 68.0 75.0 68.0 67.0 68.0 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 08:52:01 INFO - 2015-12-17 08:52:01,063 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 85.0 84.0 85.0 86.0 84.0 85.0 86.0 08:52:01 INFO - 2015-12-17 08:52:01,064 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,064 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.50 stddev:4.42 (3.7%) stddev-sans-first:4.61 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: Values: 116.0 123.0 119.0 114.0 124.0 115.0 115.0 123.0 122.0 112.0 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:150.50 stddev:4.55 (3.0%) stddev-sans-first:4.74 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: Values: 145.0 140.0 142.0 149.0 152.0 143.0 151.0 152.0 151.0 150.0 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 66.0 70.0 67.0 65.0 67.0 67.0 67.0 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:01 INFO - 2015-12-17 08:52:01,065 DEBUG : BROWSER_OUTPUT: 08:52:01 INFO - 2015-12-17 08:52:01,867 INFO : Browser exited with error code: 0 08:52:01 INFO - 2015-12-17 08:52:01,920 INFO : Completed test kraken (00:00:58) 08:52:01 INFO - 2015-12-17 08:52:01,920 INFO : Starting test v8_7 08:52:01 INFO - 2015-12-17 08:52:01,920 DEBUG : operating with platform_type : linux_ 08:52:01 INFO - 2015-12-17 08:52:01,920 INFO : Initialising browser for v8_7 test... 08:52:01 INFO - 2015-12-17 08:52:01,926 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5fkHE3/profile http://localhost:52390/getInfo.html 08:52:05 INFO - 2015-12-17 08:52:05,943 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:52:05 INFO - 2015-12-17 08:52:05,943 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:52:05 INFO - 2015-12-17 08:52:05,943 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:52:05 INFO - 2015-12-17 08:52:05,943 DEBUG : BROWSER_OUTPUT: __metrics 08:52:06 INFO - 2015-12-17 08:52:06,040 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:52:06 INFO - 2015-12-17 08:52:06,096 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:06 INFO - 2015-12-17 08:52:06,931 INFO : Browser initialized. 08:52:06 INFO - 2015-12-17 08:52:06,932 INFO : Running cycle 1/1 for v8_7 test... 08:52:06 INFO - 2015-12-17 08:52:06,932 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5fkHE3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:52:18 INFO - 2015-12-17 08:52:18,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 150077440 08:52:18 INFO - 2015-12-17 08:52:18,672 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52390/tests/v8_7/run.html (next: http://localhost:52390/tests/v8_7/run.html) 08:52:40 INFO - 2015-12-17 08:52:40,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 585494528 08:52:40 INFO - 2015-12-17 08:52:40,261 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,261 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:40 INFO - 2015-12-17 08:52:40,261 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:40 INFO - 2015-12-17 08:52:40,261 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:40 INFO - 2015-12-17 08:52:40,261 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:40 INFO - 2015-12-17 08:52:40,261 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 08:52:40 INFO - 2015-12-17 08:52:40,262 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.09937888198758 08:52:40 INFO - 2015-12-17 08:52:40,262 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.5270768358378 08:52:40 INFO - 2015-12-17 08:52:40,262 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 08:52:40 INFO - 2015-12-17 08:52:40,262 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1081.081081081081 08:52:40 INFO - 2015-12-17 08:52:40,262 DEBUG : BROWSER_OUTPUT: |5;Earley;781.25 08:52:40 INFO - 2015-12-17 08:52:40,262 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 08:52:40 INFO - 2015-12-17 08:52:40,262 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 08:52:40 INFO - 2015-12-17 08:52:40,263 DEBUG : BROWSER_OUTPUT: |8;Splay;653.59477124183 08:52:40 INFO - 2015-12-17 08:52:40,263 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 08:52:40 INFO - 2015-12-17 08:52:40,263 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:40 INFO - 2015-12-17 08:52:40,263 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371160259__endTimestamp 08:52:40 INFO - 2015-12-17 08:52:40,263 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,264 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:40 INFO - 2015-12-17 08:52:40,264 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:52:40 INFO - 2015-12-17 08:52:40,264 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,264 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,264 DEBUG : BROWSER_OUTPUT: Values: 166.0 08:52:40 INFO - 2015-12-17 08:52:40,264 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,265 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.10 Median:194.10 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,265 DEBUG : BROWSER_OUTPUT: Values: 194.1 08:52:40 INFO - 2015-12-17 08:52:40,265 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,265 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.53 Median:283.53 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,265 DEBUG : BROWSER_OUTPUT: Values: 283.5 08:52:40 INFO - 2015-12-17 08:52:40,265 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,266 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,266 DEBUG : BROWSER_OUTPUT: Values: 5181.3 08:52:40 INFO - 2015-12-17 08:52:40,266 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,266 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,266 DEBUG : BROWSER_OUTPUT: Values: 1081.1 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.25 Median:781.25 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: Values: 781.3 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: Values: 12096.4 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,267 DEBUG : BROWSER_OUTPUT: Values: 26763.2 08:52:40 INFO - 2015-12-17 08:52:40,268 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,268 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:653.59 Median:653.59 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,269 DEBUG : BROWSER_OUTPUT: Values: 653.6 08:52:40 INFO - 2015-12-17 08:52:40,269 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2015-12-17 08:52:40,269 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:52:40 INFO - 2015-12-17 08:52:40,269 DEBUG : BROWSER_OUTPUT: Values: 4826.9 08:52:40 INFO - 2015-12-17 08:52:40,269 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:40 INFO - 2015-12-17 08:52:40,269 DEBUG : BROWSER_OUTPUT: 08:52:41 INFO - 2015-12-17 08:52:41,075 INFO : Browser exited with error code: 0 08:52:41 INFO - 2015-12-17 08:52:41,087 INFO : Completed test v8_7 (00:00:39) 08:52:41 INFO - 2015-12-17 08:52:41,331 INFO : Completed test suite (00:20:10) 08:52:41 INFO - 2015-12-17 08:52:41,331 DEBUG : Working with test: dromaeo_css 08:52:41 INFO - 2015-12-17 08:52:41,331 DEBUG : Generating results file: dromaeo_css 08:52:41 INFO - 2015-12-17 08:52:41,332 DEBUG : Working with test: kraken 08:52:41 INFO - 2015-12-17 08:52:41,333 DEBUG : Generating results file: kraken 08:52:41 INFO - 2015-12-17 08:52:41,333 INFO : javascript benchmark 08:52:41 INFO - 2015-12-17 08:52:41,333 DEBUG : Working with test: v8_7 08:52:41 INFO - 2015-12-17 08:52:41,333 DEBUG : Generating results file: v8_7 08:52:41 INFO - 2015-12-17 08:52:41,333 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:41 INFO - 2015-12-17 08:52:41,392 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:52:41 INFO - 2015-12-17 08:52:41,392 DEBUG : process_Request line: dromaeo_css 6882.45 graph.html#tests=[[72,201,35]] 08:52:41 INFO - 2015-12-17 08:52:41,392 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:41 INFO - 2015-12-17 08:52:41,423 DEBUG : process_Request line: kraken 1494.50 graph.html#tests=[[232,201,35]] 08:52:41 INFO - 2015-12-17 08:52:41,423 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:41 INFO - 2015-12-17 08:52:41,452 DEBUG : process_Request line: v8_7 20816.72 graph.html#tests=[[230,201,35]] 08:52:41 INFO - 2015-12-17 08:52:41,454 INFO : javascript benchmark 08:52:41 INFO - 2015-12-17 08:52:41,457 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3171.8572664230114, 3204.47126224173, 3261.9673803261976, 3262.820544870033, 3286.2770190558076, 5175.689458632475, 5260.263563101169, 5368.087425137726, 5409.729513524323, 5461.262729531517, 5294.470552944704, 5397.163439666848, 5409.810656627019, 5421.484958928895, 5444.183372494128, 4890.584300334476, 4944.480829512903, 4960.528749768766, 4964.0, 5014.373203349582, 4748.3827102476625, 4962.702237865721, 4988.975055124719, 5016.072026675059, 5043.924341134868, 4766.499517550659, 4775.617950563981, 4886.53577910098, 4889.779959901813, 4902.460729319772, 4859.125357435661, 4890.217565189552, 4904.092742842586, 4908.779104940286, 4945.381827271591, 4703.082898834728, 4849.272609108627, 4870.220764677634, 4873.8781530461665, 4933.506649335073, 5066.569341605931, 5147.562457191143, 5153.020926024081, 5189.7405129743365, 5192.065428222918, 5710.200571919934, 5711.8000869969765, 5713.171590119409, 5718.399568045337, 5719.942800572025, 5742.770289188427, 5747.568932330092, 5787.33445653751, 5798.594098413113, 5800.651960882361, 5258.947410525922, 5322.92015619766, 5335.226392173113, 5354.866128346823, 5358.089124848785, 5873.676947767828, 5879.706014699248, 5882.147088672119, 5888.440598143169, 5932.2584676915385, 5695.0, 5706.229658996065, 5707.543396528268, 5709.400512946081, 5759.22250496186, 5663.716814159358, 5789.942100579025, 5844.88310233793, 5869.501092407193, 5914.58597898143, 5817.592768506164, 5818.040023396177, 5851.151583020438, 5861.238039054895, 5861.35525092248, 5719.113537401709, 5834.737436815353, 5835.474807267281, 5838.416158384212, 5838.941610583925, 4408.9559104408545, 4440.444944381952, 4451.844185453494, 4500.122476117126, 4506.977465112654, 3968.5634580196156, 3978.2407269032215, 3992.441058251847, 4000.6399424051974, 4014.578469260744, 5519.0, 5525.475079867406, 5527.723613819293, 5527.917081243784, 5580.525655319262, 5650.858728531737, 5737.397573254748, 5796.8550786229835, 5805.88388232233, 5860.912086318709, 5482.342118945672, 5508.366537848118, 5526.392096869341, 5527.060399732055, 5532.861678458071, 5026.0, 5044.571211447068, 5044.924326135111, 5050.3939527256225, 5093.057784309841, 5844.912326315109, 5975.372585878507, 5975.43233392827, 6012.7895523657335, 6106.224627875458, 5775.249217601685, 5785.132230165509, 5796.739146738322, 5845.561582881216, 5853.326867410132, 6008.7296071676, 6010.278766548042, 6013.398660133952, 6016.699165041818, 6026.0659597762415, 5715.885682286248, 5768.307803063659, 5785.450382213683, 5826.941730582809, 5906.557008224487, 5858.062709966385, 5887.470127688357, 5899.882002359843, 5903.763849446146, 5906.084556893688, 5731.770729170787, 5746.138079287973, 5749.080147176432, 5750.6837123958585, 5755.309362876482, 5561.860953476195, 5675.602707810413, 5677.290338707661, 5712.914306285492, 5856.824295271149, 5634.605577609528, 5636.605437619327, 5638.126090455986, 5639.379668236573, 5642.435756424489, 5680.318361796611, 5683.573731970201, 5696.487316141402, 5744.798932037359, 5746.080627099644, 5380.192971054373, 5450.890982180414, 5471.835844924659, 5479.287692599936, 5590.105583106846], "unit": "score", "name": "dojo.html", "value": 5342.256037307579}, {"lowerIsBetter": false, "replicates": [566.5354409384306, 610.3560743415696, 614.9016157414811, 617.3764497857163, 618.0266080922547, 36358.45462318064, 37322.4401633975, 37370.43944340837, 37399.065023374395, 37419.62580374199, 41663.0, 42221.0, 42227.36658950118, 42261.57738422615, 42327.365089523606, 7217.278272172794, 7284.2351553086955, 8638.265747411477, 8822.161894620001, 9985.90014099857, 10180.796384072351, 10276.691699248997, 10285.331453455501, 10311.226658000642, 10313.587456501731, 10261.0, 10387.220958428148, 10388.63639772608, 10389.0, 10393.480325983708, 7702.653380597886, 7863.724769633064, 10173.338732982333, 10391.688249352455, 10393.90863959281, 9846.60613575456, 10034.046765557261, 10046.146077583415, 10050.748731281703, 10058.899411005943, 38510.80744596287, 38901.61098389008, 39064.414033789515, 39075.218495630215, 39235.21529569421, 3003.8648260828313, 3008.337621205227, 3052.3895220955897, 3067.3251884585356, 3694.963050369489, 29719.95980140706, 29733.10800675983, 31906.840465797755, 31961.200969975704, 32176.356472870644, 3913.7064720146104, 3927.8428862845453, 3936.547297060846, 3966.682665386791, 4031.2743706132883, 250160.0, 252166.0, 252353.73823130951, 253298.0, 253813.0, 50972.235416468786, 51446.485535144915, 58312.0, 58749.0, 58779.0, 69605.0, 70790.2920970794, 70906.0, 70995.0, 71079.64460177666, 13866.237356945465, 14016.929915350358, 14072.788908166385, 14072.929635351758, 14174.220417877115, 10484.475776211159, 10506.632267870587, 10579.153667706565, 10591.523381447852, 10597.682069537927, 19820.504487387643, 20193.293234736713, 20240.19039238414, 20268.797312026985, 20293.594128117355, 8030.678772849021, 8115.837683246302, 8134.918650813534, 8231.34149268069, 8279.50322980623, 886.9157430044136, 903.5256490342491, 973.9902600974041, 1021.9029192226726, 1028.7993841201044, 31835.363292734015, 32632.347353052806, 32743.0, 32982.340353192805, 33138.66861331404, 958.0371726414909, 973.6689525561343, 1001.47923079998, 1028.3932479836783, 1092.5684354679856, 13944.0, 13967.720645587031, 14007.159570425807, 14217.43130274798, 14260.786088208684, 354310.0, 354640.0, 356515.0, 357795.0, 359816.0, 50054.74972625114, 50318.0, 50337.74831125821, 50390.49609503858, 50493.0, 1297.3253907967992, 1304.373900527752, 1321.8612045735251, 1322.4511827591634, 1427.222163920645, 25249.368765781004, 25705.35736606525, 26486.867565662047, 30296.5455518163, 31539.52690709687, 47570.52429475661, 47719.0, 48065.75967120142, 48136.518634813205, 48137.0, 278547.0, 279652.0, 280496.0, 281109.0, 281443.0, 30950.845245773628, 44471.55528444803, 44572.0, 44745.77627111843, 45845.54154458413, 41981.160376792905, 42042.789786050875, 42132.57867421286, 42310.78844605757, 42871.0, 34869.1282717924, 34981.12547186341, 35051.64948350586, 35829.82085089662, 36184.0, 31060.0, 34759.82620086883, 35297.64702352943, 36863.81568092143, 38158.47366105325, 33346.33307333888, 34234.82882585571, 34446.0, 34546.0, 34557.308853823284, 28847.0, 30147.547786782776, 31153.844230779607, 32063.839680801448, 32192.517112243804, 25985.6102158464, 27319.453610928067, 27322.726772732814, 27356.452870942867, 27415.451690966467], "unit": "score", "name": "ext.html", "value": 18800.045829695988}, {"lowerIsBetter": false, "replicates": [343.63746247708673, 353.99999999999994, 354.69319039031234, 355.1529601899469, 355.8896742009977, 14261.857381426182, 14307.570772876805, 16866.409675661354, 17372.73940890886, 18393.908030459846, 12138.939305303462, 12665.113442059059, 14497.49258775943, 14820.258987050658, 14830.925845370784, 5007.298978143072, 5122.359705036871, 5124.641275110744, 5129.0, 5129.717865517395, 3726.4596633488127, 3836.2327534493074, 5075.949240507584, 5086.237064440345, 5107.438181799999, 5480.3971563128025, 5648.774049038034, 5673.489385955263, 5673.773049078052, 5676.3188417389765, 5549.972250138764, 5631.0, 5647.491725744682, 6121.449069583714, 6154.292256390483, 5446.564274858002, 5451.918221226685, 5453.972730136364, 5472.151816468454, 5477.4796394342475, 13107.410166542528, 13216.537421190309, 13247.66880827987, 13281.468741250339, 18476.98376589287, 1933.419974007792, 2086.7078608994752, 2206.5917805206086, 2216.5345277491747, 2248.022110381989, 9139.588718507683, 9178.724638260863, 9416.576254068583, 9515.23878089751, 9570.712878613653, 1755.139981409113, 1779.217144456435, 1810.8913465192, 1818.8817726847712, 1839.0712690091418, 57899.0, 59883.40116598865, 60755.0, 60845.695771520855, 61099.38900610981, 9216.124468175512, 9259.120383563552, 9718.562664680107, 9761.755956101155, 9772.804543909224, 11714.941425292818, 11777.352245626573, 11787.528498859949, 11830.704232394259, 11836.349000805038, 7030.402415794715, 7040.0, 7050.224475307815, 7111.751088711871, 7114.964425177841, 6860.416864566468, 6871.553349032297, 6899.068625735462, 6913.861722765517, 6939.826504337331, 4179.2895207814745, 4210.536840947493, 4263.4031235627035, 4304.4834619845815, 4477.261251893401, 1644.136828165199, 1701.574606348413, 1738.2438639191992, 1750.3523696232476, 1754.596442818159, 417.0678533477675, 418.3452896217471, 881.8280435315052, 966.9750064931195, 986.6990567876867, 9925.553350099262, 10186.694399168036, 10417.322874013165, 10498.10766084876, 10504.684859454228, 388.2080555666409, 434.5676052327954, 441.4900789588031, 452.3057107340217, 461.8822200338892, 5608.130739735348, 5797.304323481209, 5834.183214349994, 5934.495567876779, 5960.105984102419, 529030.0, 540019.0, 546088.0, 546488.0, 551346.0, 77806.0, 78607.21392786, 79379.60310198528, 80186.0, 80190.59904700555, 486.11284405959265, 487.9609631229493, 488.7727206848904, 490.16671658181235, 490.5952589113995, 9881.950590247003, 9997.100260976547, 10005.699829005142, 10117.0, 10190.286679932333, 32921.34157316888, 33254.66745332516, 33261.33477330488, 33324.33351332911, 34166.82916585401, 47443.288350674076, 47936.5206347932, 48035.0, 48096.0, 49649.75175124101, 9119.179273865384, 9149.679761208326, 9290.767730806783, 9292.070792920655, 9451.102145296185, 11335.319880807177, 15315.61710957235, 16423.507294781175, 17276.74084888753, 17416.390426335016, 14521.128732276096, 14539.85460145385, 14847.183404912834, 14865.182414966848, 14900.701985960004, 14432.494862679756, 14506.419743210154, 14532.128072315694, 14771.409143634135, 14890.702185956437, 12313.56902508408, 14862.479813206486, 15127.470538531099, 15158.16630085356, 15315.617109571904, 8369.288610467935, 8880.73357799267, 8995.190432861074, 9007.954960225157, 9092.363534552782, 13126.40931158081, 13954.116194313638, 14006.159630422208, 14068.437262509386, 14528.927355363156], "unit": "score", "name": "jquery.html", "value": 7832.050188397157}, {"lowerIsBetter": false, "replicates": [1340.9396577154039, 1443.213448670475, 1500.6398464368551, 1608.8069431668202, 1776.0941919620998, 6911.447084233262, 7610.619469026554, 7776.18350073242, 7787.182345853689, 7791.883121753164, 7472.476926615139, 7625.0, 7636.88544671829, 7638.847223055535, 7643.082830060386, 1983.990080049605, 2024.2712623455545, 2259.3109101723967, 2282.7032485776867, 2312.109837712476, 2278.327893271489, 2282.7032485776826, 2286.5655525450193, 2287.885605719716, 2289.9885500572473, 2203.504211552404, 2293.552757212344, 2297.4026753044245, 2299.9540009199804, 2300.7584203658625, 2296.954060918789, 2304.8617082974993, 2309.7690230976937, 2310.8151347892126, 2313.849599776009, 2285.3372521968777, 2306.077568972408, 2325.767423257678, 2341.2156927429332, 2342.426105604121, 7556.584387858666, 7614.695412183506, 7619.657115429819, 7620.771376858703, 7623.2376762323875, 4632.0967411354795, 4732.716037037789, 4734.786934587952, 4738.739369334685, 4740.407449068866, 3048.832314222717, 3114.019083988559, 3135.372925414926, 3191.5850939377733, 3229.7093261606333, 972.9221662267001, 976.4922240434934, 997.8952210017989, 1027.126942099217, 1053.5364439646607, 10424.061834434862, 10426.061654451136, 10457.0, 10467.738306542398, 10475.47622618866, 4375.803088861009, 4417.3815665806815, 4431.8448854289945, 4479.417675702138, 4500.189965806187, 9016.684416045538, 9025.684101056431, 9027.954860225656, 9034.32242581809, 9057.365984381162, 4718.197906355927, 4719.740414277179, 4733.313669517969, 4742.288656701522, 4746.928796068062, 4214.009707718684, 4269.850555230552, 4284.635805956528, 4292.720973136736, 4305.698601097955, 3192.553042573995, 3196.184972831913, 3265.4775235962134, 3292.93414131716, 3609.9639003609627, 1196.9281843089443, 1213.6783752305646, 1216.0818581970555, 1219.40249277855, 1221.3099598726692, 982.219135787051, 986.329296078659, 1051.148569658579, 1054.9450549450548, 1193.3734789235548, 7314.122305323289, 7374.705011799575, 7383.81540461482, 7392.852142957111, 7398.186199518049, 1099.3623698254994, 1108.8669359676728, 1112.8052590796578, 1114.0920150077661, 1114.1421105748527, 5636.830895073154, 5719.2279042328755, 5749.798757043483, 5756.856078598069, 5763.308402991668, 8746.169113934166, 9212.170904618617, 9228.676996305232, 9236.953815230881, 9251.49116798569, 8982.101789820965, 9021.0, 9050.773730656654, 9056.818863622691, 9062.139096785795, 6760.594364338155, 6991.23096459389, 7045.753398631024, 7050.858982820315, 7093.82265443368, 7157.749478768218, 7161.892571611325, 7171.533850299714, 7215.530990485601, 7215.963920180366, 7745.109312429143, 7989.0, 8084.191580842104, 8174.346052315919, 8187.3040791531, 8055.436119471581, 8203.83592328162, 8207.507549547046, 8218.260356567938, 8246.340292776684, 6743.431642027508, 6823.385895269251, 6953.548019378724, 6965.965170174117, 6979.755708550177, 6357.8728425432155, 6567.31043240472, 6806.76176333826, 6996.895046574204, 7552.093748750185, 6888.0, 6992.16094068715, 7054.964725176341, 7109.075820143348, 7144.67848946809, 6827.180738311435, 6914.239433662394, 6984.511084224056, 7083.858322833411, 7119.9644001781735, 7019.6841142147705, 7062.0466237057335, 7068.081149450744, 7075.433965282662, 7076.823079423056, 6500.674966251574, 6522.543421960418, 6535.738570457129, 6555.672216389066, 6577.736890524326, 6495.902561461677, 6525.184351956005, 6536.869262614816, 6542.378474044958, 6547.377999090078], "unit": "score", "name": "mootools.html", "value": 4435.727009334741}, {"lowerIsBetter": false, "replicates": [338.7222477568394, 345.94118999770035, 348.28427581320386, 352.8412214503474, 356.8947160587628, 5904.6457212567275, 5917.763289468421, 6036.396360363967, 6047.274327080745, 6071.423214794588, 5778.0466223073245, 5917.911231331534, 5950.940490595092, 5965.522758179346, 5974.283086029672, 4611.584957353846, 4619.838305659303, 4624.583787459128, 4627.051454451829, 4631.374764406795, 4408.20652282589, 4463.598276155145, 4561.247394179956, 4604.447466304048, 4624.213883639789, 4499.595036446719, 4502.954970450286, 4503.166914120881, 4524.434445694288, 4578.816847326103, 4513.119941611387, 4556.77216139195, 4577.130345234428, 4587.3807036050375, 4611.4005179326805, 4079.0822065035427, 4081.3061779497557, 4084.4690190275073, 4086.856960006415, 4088.632023117934, 5552.333719953632, 5670.404607516192, 5676.716164191816, 5692.430756924316, 5713.942860571383, 5343.278657381243, 5343.946560534384, 5348.251244825728, 5348.502419322596, 5359.866003349947, 6060.818175454743, 6376.075469056961, 6387.808365749035, 6392.689498652765, 6400.263969643457, 4277.230098582254, 4327.06968001878, 4408.669349798778, 4446.444194475691, 4447.266201076818, 6507.44686701631, 6588.670566471657, 6608.702608382586, 6613.371729685672, 6622.238442579117, 4521.660875434355, 4538.364628951949, 4542.931856022163, 4544.068465964469, 4547.3179023146795, 4501.7524036177665, 4586.495485496593, 4592.586667199968, 4600.42494688164, 4616.953830461653, 5297.708626025528, 5301.443348448434, 5307.840764777063, 5315.0, 5315.495027972336, 6397.424231819065, 6401.3278605746655, 6404.839879002969, 6406.135171751847, 6409.551331406757, 1602.1268408717276, 1607.6382813866787, 1608.0271435781417, 1608.6300150965344, 1610.7825443565202, 1058.2116323339162, 1061.639042725477, 1066.0618655583191, 1071.978560428787, 1091.1761619976867, 6219.875602488016, 6244.46922011625, 6260.092286618415, 6263.404976527223, 6266.122742816009, 6623.635700036448, 6624.8012559623285, 6626.608412233485, 6631.701573429207, 6661.600303981777, 5986.0, 6152.446279834837, 6161.44546990773, 6162.784302549389, 6165.290991535941, 3586.6592673696478, 3599.9280014399565, 3606.9179246226026, 3611.1513794258326, 3623.0942264433893, 6770.69531871067, 6774.424173945171, 6778.457723382117, 6786.660666966632, 6790.694418751168, 6652.467802575782, 6758.93241067583, 6767.0, 6790.151231096113, 6792.864142717118, 6843.349881761224, 6845.691943862538, 6854.0404343391965, 6862.073620061228, 6873.037774711544, 6434.06706027614, 6624.403803657694, 6626.4367528760595, 6629.502787290876, 6642.933570664231, 6448.387403196689, 6486.805395838132, 6493.805185844432, 6494.642794646151, 6577.835554110994, 6914.0320355151325, 6917.584944903322, 6921.89617155733, 6931.930680693128, 6934.791956241119, 4438.267685831931, 4537.773111344485, 4542.613877820422, 4543.159515489645, 4547.795349209359, 6645.60126392418, 6670.966645166744, 6681.832954176184, 6684.933150668431, 6690.632015239208, 6443.6133831968355, 6471.25580558223, 6473.482121430368, 6492.675366231764, 6493.902591461037, 6309.968450157719, 6469.159009328757, 6475.870482590228, 6479.254885688206, 6534.313897040743, 6365.872682546231, 6379.202599675041, 6388.456981156468, 6397.6481293529305, 6398.104265402941, 6551.246606640298, 6553.180852393451, 6556.409923106943, 6560.573562718408, 6564.770233041821, 6235.96882015587, 6322.083297921868, 6325.652089135142, 6371.044343348535, 6398.360163983564], "unit": "score", "name": "prototype.html", "value": 4830.27769466156}, {"lowerIsBetter": false, "replicates": [752.861872282717, 758.4577027425391, 767.8234006178578, 774.8527779721849, 844.6790219716506, 12549.560765373202, 12998.15511991721, 13007.674808129801, 13021.28382938938, 13045.021623378248, 13293.534726284583, 13391.598252052454, 13392.397342119604, 13401.195928244311, 13412.26232557209, 683.5966779600035, 696.5785699651714, 698.7030512032392, 838.2748922182315, 854.6068808348167, 694.0422217340089, 832.5545832979358, 850.4344610833788, 851.748734123435, 854.7521218846528, 887.1926546842375, 887.9822403551925, 893.7497500699782, 893.9240164585985, 894.217559635319, 705.9117610298713, 881.3918396306592, 884.1114679746845, 884.1158841158841, 887.7691800131947, 528.632600342762, 631.1668597451365, 644.7292137302297, 647.0520687193238, 648.3937518420292, 12765.872341276561, 12952.093353465261, 13062.346882655924, 13079.86920130796, 13088.149270297401, 12199.390030498529, 12627.368631568384, 12692.30192339421, 12789.936050319782, 13167.934160329138, 10048.69853904384, 10190.541425635864, 10250.589976400935, 10277.48612569376, 10595.629152979685, 3625.474306225609, 3637.7089832813313, 3665.651763082503, 3692.7599706019023, 3763.360228761117, 42500.57499424997, 42758.78620606908, 42788.57211427877, 42956.57043429557, 43230.35154472717, 9685.806283874283, 9816.165625921734, 9903.158231550398, 9903.356281841658, 10080.445575493419, 17328.220230089675, 17332.740008899877, 17355.65288694219, 17368.4789456314, 17372.0, 7383.114026316876, 7542.0, 7551.848963020709, 7586.658600362997, 7772.65023073963, 4385.780710964503, 4398.23030969579, 4408.713433626868, 4409.162259170811, 4426.313921342197, 3175.587173667455, 3190.744740420761, 3209.021248519224, 3209.422303985305, 3214.244652506659, 573.3578392200678, 578.8784355285437, 595.5503594785908, 596.5138412194048, 605.1890466774455, 486.8515102893581, 509.80882169186555, 520.1495554767981, 536.7584586935816, 547.2065505017661, 8965.462072275684, 9265.305102117369, 9420.905790942003, 9731.56207970643, 9815.852762208573, 594.180031556458, 598.6557729305666, 672.9226138994078, 694.9965250173818, 710.3571268002466, 3919.6864250859862, 4034.6570541503716, 4051.2707712612014, 4071.959280407217, 4142.46148000764, 55896.44103558912, 61505.38494615086, 61998.0, 62007.68996155081, 62280.377196228364, 50780.746096269286, 51129.48870511322, 52458.0, 52508.212376813615, 53218.0, 47075.52924470711, 47293.76353118212, 47899.5210047902, 48264.75867620709, 48457.0, 8459.703910363107, 8616.741497755078, 8648.1784230498, 8813.42712723671, 8817.911820881709, 35094.29811403707, 35376.29247415089, 35452.64547354596, 36019.0, 36076.0, 46426.535734642224, 46514.76742616265, 47181.528184719085, 47289.763551182026, 47919.52080479151, 10622.681319560426, 10850.565977360817, 10936.0, 11059.778804424028, 11137.431284357821, 12420.254784712946, 12474.376281186085, 12600.959675736938, 12689.682757931125, 12731.681707957376, 11161.330320180816, 11513.366764828015, 11554.653360399201, 11816.704582385166, 11903.940480297542, 11539.538418463504, 11720.413979301171, 11879.881201187878, 12181.69545761363, 12220.938895305466, 11242.887571124184, 11286.379249141377, 11461.828072579085, 11572.768544628892, 11687.39802715306, 9174.934621603945, 9279.285979918186, 9304.82293691556, 9304.934404828657, 9539.57071931751, 8850.336224783296, 8965.731028069169, 9596.18432433251, 9795.314327997257, 9967.800643986935], "unit": "score", "name": "yui.html", "value": 6305.5592243821575}], "name": "dromaeo_css", "value": 6882.447665901229}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 110.0, 110.0, 110.0, 99.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 148.0, 158.0, 124.0, 157.0, 146.0, 129.0, 164.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 159.0, 161.0, 161.0, 159.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 84.0, 97.0, 70.0, 71.0, 77.0, 101.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 149.0, 93.0, 93.0, 93.0, 135.0, 92.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 57.0, 57.0, 58.0, 58.0, 59.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 75.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 86.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [116.0, 123.0, 119.0, 114.0, 124.0, 115.0, 115.0, 123.0, 122.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [145.0, 140.0, 142.0, 149.0, 152.0, 143.0, 151.0, 152.0, 151.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 66.0, 70.0, 67.0, 65.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1494.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [194.09937888198758], "unit": "score", "name": "DeltaBlue", "value": 340.63993600000003}, {"lowerIsBetter": false, "replicates": [283.5270768358378], "unit": "score", "name": "Encrypt", "value": 938.8203869999999}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [781.25], "unit": "score", "name": "Earley", "value": 853.0726399999998}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [653.59477124183], "unit": "score", "name": "Splay", "value": 124.68123000000001}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20816.71611409989}]} 08:52:41 INFO - RETURN: dromaeo_css: 6882.45 08:52:41 INFO - RETURN: kraken: 1494.50 08:52:41 INFO - RETURN: v8_7: 20816.72 08:52:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20816.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1494.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6882.45"}}} 08:52:41 INFO - Return code: 0 08:52:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:52:41 INFO - # TBPL SUCCESS # 08:52:41 INFO - Running post-action listener: _resource_record_post_action 08:52:41 INFO - Running post-run listener: _resource_record_post_run 08:52:42 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 24576; Write bytes: 561610752; Read time: 76; Write time: 519280 08:52:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251138048; Read time: 0; Write time: 326228 08:52:42 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 24576; Write bytes: 310472704; Read time: 76; Write time: 193052 08:52:42 INFO - Running post-run listener: _upload_blobber_files 08:52:42 INFO - Blob upload gear active. 08:52:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:52:42 INFO - Copying logs to upload dir... 08:52:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.903059 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-17 08:52:42.649827) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:52:42.653744) ========= 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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009837 build_url: 'https://queue.taskcluster.net/v1/task/Ufvd80fSRbuLAhH8DdPTCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.09 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:52:42.756753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:52:42.757092) ========= 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=f5f5a079460e1a9be8676904000001c1-1450369634.952862-785121302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004732 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:52:42.807349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 08:52:42.807669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 08:52:42.807999) ========= ========= Total master_lag: 0.25 =========