builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1450379306.82 results: success (0) buildid: 20151217083216 builduid: 4ac43606da7d40288db14f7a163641d1 revision: 327f0142e1a78bef241999e9679a357e75ff9698 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.824672) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.825074) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.825368) ========= 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=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005886 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.876293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.876604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.918155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.918449) ========= 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=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025393 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.969270) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.969643) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.970057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:26.970665) ========= 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=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 11:08:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2015-12-17 11:08:27 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.192151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.192497) ========= 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=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.132726 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.335306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.335647) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 327f0142e1a78bef241999e9679a357e75ff9698 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 327f0142e1a78bef241999e9679a357e75ff9698 --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=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 11:08:27,422 truncating revision to first 12 chars 2015-12-17 11:08:27,422 Setting DEBUG logging. 2015-12-17 11:08:27,422 attempt 1/10 2015-12-17 11:08:27,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/327f0142e1a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 11:08:27,663 unpacking tar archive at: fx-team-327f0142e1a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.880750) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.881065) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.891116) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.891409) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 11:08:27.891860) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 11:08:27.892168) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:28 INFO - MultiFileLogger online at 20151217 11:08:28 in /builds/slave/test-pgo 11:08:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:08:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:08:28 INFO - {'append_to_log': False, 11:08:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:08:28 INFO - 'blob_upload_branch': 'Fx-Team', 11:08:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:08:28 INFO - 'branch': 'Fx-Team', 11:08:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:28 INFO - 'config_files': ('talos/linux_config.py',), 11:08:28 INFO - 'default_actions': ('clobber', 11:08:28 INFO - 'read-buildbot-config', 11:08:28 INFO - 'download-and-extract', 11:08:28 INFO - 'populate-webroot', 11:08:28 INFO - 'create-virtualenv', 11:08:28 INFO - 'install', 11:08:28 INFO - 'run-tests'), 11:08:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:28 INFO - 'download_minidump_stackwalk': True, 11:08:28 INFO - 'download_symbols': 'ondemand', 11:08:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:28 INFO - 'installer_path': 'installer.exe', 11:08:28 INFO - 'log_level': 'info', 11:08:28 INFO - 'log_name': 'talos', 11:08:28 INFO - 'log_to_console': True, 11:08:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:28 INFO - 'opt_config_files': (), 11:08:28 INFO - 'pip_index': False, 11:08:28 INFO - 'sps_profile': False, 11:08:28 INFO - 'sps_profile_interval': 0, 11:08:28 INFO - 'suite': 'dromaeojs', 11:08:28 INFO - 'system_bits': '64', 11:08:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:28 INFO - 'title': 'talos-linux64-ix-006', 11:08:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:28 INFO - 'use_talos_json': True, 11:08:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:08:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:28 INFO - 'work_dir': 'build'} 11:08:28 INFO - ##### 11:08:28 INFO - ##### Running clobber step. 11:08:28 INFO - ##### 11:08:28 INFO - Running pre-action listener: _resource_record_pre_action 11:08:28 INFO - Running main action method: clobber 11:08:28 INFO - rmtree: /builds/slave/test-pgo/build 11:08:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:08:32 INFO - Running post-action listener: _resource_record_post_action 11:08:32 INFO - ##### 11:08:32 INFO - ##### Running read-buildbot-config step. 11:08:32 INFO - ##### 11:08:32 INFO - Running pre-action listener: _resource_record_pre_action 11:08:32 INFO - Running main action method: read_buildbot_config 11:08:32 INFO - Using buildbot properties: 11:08:32 INFO - { 11:08:32 INFO - "project": "", 11:08:32 INFO - "product": "firefox", 11:08:32 INFO - "script_repo_revision": "production", 11:08:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:08:32 INFO - "repository": "", 11:08:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:08:32 INFO - "buildid": "20151217083216", 11:08:32 INFO - "pgo_build": "True", 11:08:32 INFO - "basedir": "/builds/slave/test-pgo", 11:08:32 INFO - "buildnumber": 551, 11:08:32 INFO - "slavename": "talos-linux64-ix-006", 11:08:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:08:32 INFO - "platform": "ubuntu64_hw", 11:08:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:08:32 INFO - "branch": "fx-team", 11:08:32 INFO - "repo_path": "integration/fx-team", 11:08:32 INFO - "revision": "327f0142e1a78bef241999e9679a357e75ff9698", 11:08:32 INFO - "stage_platform": "linux64-pgo", 11:08:32 INFO - "builduid": "4ac43606da7d40288db14f7a163641d1", 11:08:32 INFO - "slavebuilddir": "test" 11:08:32 INFO - } 11:08:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:08:32 INFO - Running post-action listener: _resource_record_post_action 11:08:32 INFO - ##### 11:08:32 INFO - ##### Running download-and-extract step. 11:08:32 INFO - ##### 11:08:32 INFO - Running pre-action listener: _resource_record_pre_action 11:08:32 INFO - Running main action method: download_and_extract 11:08:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:32 INFO - https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/test_packages.json 11:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/test_packages.json 11:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:08:35 INFO - Downloaded 1302 bytes. 11:08:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:08:35 INFO - Using the following test package requirements: 11:08:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:35 INFO - u'jsshell-linux-x86_64.zip'], 11:08:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:08:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:08:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08:35 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')]} 11:08:35 INFO - https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:36 INFO - Downloaded 23119750 bytes. 11:08:37 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 11:08:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:08:37 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 11:08:38 INFO - Return code: 0 11:08:38 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 11:08:38 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')]} 11:08:38 INFO - https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:40 INFO - Downloaded 23119750 bytes. 11:08:40 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 11:08:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:08:40 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 11:08:42 INFO - Return code: 0 11:08:42 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')]} 11:08:42 INFO - https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:43 INFO - Downloaded 11132039 bytes. 11:08:43 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 11:08:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:08:43 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 11:08:43 INFO - Return code: 0 11:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:43 INFO - https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jdki7IJGTY2bmN8jtVYDIA/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 11:08:44 INFO - Downloaded 54652501 bytes. 11:08:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:08:44 INFO - mkdir: /builds/slave/test-pgo/properties 11:08:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:08:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:08:44 INFO - Contents: 11:08:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:08:44 INFO - Running post-action listener: _resource_record_post_action 11:08:44 INFO - Running post-action listener: set_extra_try_arguments 11:08:44 INFO - ##### 11:08:44 INFO - ##### Running populate-webroot step. 11:08:44 INFO - ##### 11:08:44 INFO - Running pre-action listener: _resource_record_pre_action 11:08:44 INFO - Running main action method: populate_webroot 11:08:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:44 INFO - '--tppagecycles', 11:08:44 INFO - '7'], 11:08:44 INFO - 'tests': ['tsvgm']}}, 11:08:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:08:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:08:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:08:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'tests': ['damp', 'tps']}, 11:08:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['damp', 'tps']}, 11:08:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:08:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:44 INFO - 'other': {'tests': ['a11yr', 11:08:44 INFO - 'ts_paint', 11:08:44 INFO - 'tpaint', 11:08:44 INFO - 'sessionrestore', 11:08:44 INFO - 'sessionrestore_no_auto_restore']}, 11:08:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['a11yr', 11:08:44 INFO - 'ts_paint', 11:08:44 INFO - 'tpaint', 11:08:44 INFO - 'sessionrestore', 11:08:44 INFO - 'sessionrestore_no_auto_restore']}, 11:08:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['a11yr', 11:08:44 INFO - 'ts_paint', 11:08:44 INFO - 'tpaint', 11:08:44 INFO - 'sessionrestore', 11:08:44 INFO - 'sessionrestore_no_auto_restore']}, 11:08:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['a11yr', 11:08:44 INFO - 'ts_paint', 11:08:44 INFO - 'tpaint', 11:08:44 INFO - 'sessionrestore', 11:08:44 INFO - 'sessionrestore_no_auto_restore']}, 11:08:44 INFO - 'other_l64': {'tests': ['a11yr', 11:08:44 INFO - 'ts_paint', 11:08:44 INFO - 'tpaint', 11:08:44 INFO - 'sessionrestore', 11:08:44 INFO - 'sessionrestore_no_auto_restore']}, 11:08:44 INFO - 'other_nol64': {'tests': ['a11yr', 11:08:44 INFO - 'ts_paint', 11:08:44 INFO - 'tpaint', 11:08:44 INFO - 'sessionrestore', 11:08:44 INFO - 'sessionrestore_no_auto_restore']}, 11:08:44 INFO - 'svgr': {'tests': ['tsvgx', 11:08:44 INFO - 'tsvgr_opacity', 11:08:44 INFO - 'tart', 11:08:44 INFO - 'tscrollx', 11:08:44 INFO - 'cart']}, 11:08:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['tsvgx', 11:08:44 INFO - 'tsvgr_opacity', 11:08:44 INFO - 'tart', 11:08:44 INFO - 'tscrollx', 11:08:44 INFO - 'cart']}, 11:08:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'tests': ['tp5o']}, 11:08:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'talos_options': ['--e10s'], 11:08:44 INFO - 'tests': ['tp5o']}, 11:08:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'talos_options': ['--xperf_path', 11:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:44 INFO - 'tests': ['tp5n']}, 11:08:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:44 INFO - 'talos_options': ['--e10s', 11:08:44 INFO - '--xperf_path', 11:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:44 INFO - 'tests': ['tp5n']}}, 11:08:44 INFO - 'talos.zip': {'path': '', 11:08:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:44 INFO - Running post-action listener: _resource_record_post_action 11:08:44 INFO - ##### 11:08:44 INFO - ##### Running create-virtualenv step. 11:08:44 INFO - ##### 11:08:44 INFO - Running pre-action listener: _resource_record_pre_action 11:08:44 INFO - Running main action method: create_virtualenv 11:08:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:08:44 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 11:08:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:08:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:44 INFO - Using real prefix '/usr' 11:08:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:08:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:47 INFO - Installing pip.................done. 11:08:47 INFO - Return code: 0 11:08:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:08: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')]} 11:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:47 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:08:47 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 11:08:47 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 11:08:47 INFO - Using env: {'DISPLAY': ':0', 11:08:47 INFO - 'HOME': '/home/cltbld', 11:08:47 INFO - 'LANG': 'en_US.UTF-8', 11:08:47 INFO - 'LANGUAGE': 'en_US:en', 11:08:47 INFO - 'LOGNAME': 'cltbld', 11:08:47 INFO - 'MAIL': '/var/mail/cltbld', 11:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:47 INFO - 'MOZ_NO_REMOTE': '1', 11:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:47 INFO - 'NO_EM_RESTART': '1', 11:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:47 INFO - 'SHELL': '/bin/bash', 11:08:47 INFO - 'SHLVL': '1', 11:08:47 INFO - 'TERM': 'linux', 11:08:47 INFO - 'TMOUT': '86400', 11:08:47 INFO - 'USER': 'cltbld', 11:08:47 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:47 INFO - '_': '/tools/buildbot/bin/python'} 11:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:48 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 11:08:48 INFO - Cleaning up... 11:08:48 INFO - Return code: 0 11:08:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:08: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')]} 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:48 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:08:48 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 11:08:48 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 11:08:48 INFO - Using env: {'DISPLAY': ':0', 11:08:48 INFO - 'HOME': '/home/cltbld', 11:08:48 INFO - 'LANG': 'en_US.UTF-8', 11:08:48 INFO - 'LANGUAGE': 'en_US:en', 11:08:48 INFO - 'LOGNAME': 'cltbld', 11:08:48 INFO - 'MAIL': '/var/mail/cltbld', 11:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:48 INFO - 'MOZ_NO_REMOTE': '1', 11:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:48 INFO - 'NO_EM_RESTART': '1', 11:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:48 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:48 INFO - 'SHELL': '/bin/bash', 11:08:48 INFO - 'SHLVL': '1', 11:08:48 INFO - 'TERM': 'linux', 11:08:48 INFO - 'TMOUT': '86400', 11:08:48 INFO - 'USER': 'cltbld', 11:08:48 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:48 INFO - '_': '/tools/buildbot/bin/python'} 11:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:48 INFO - Downloading/unpacking psutil>=0.7.1 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:08:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:08:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:50 INFO - Installing collected packages: psutil 11:08:50 INFO - Running setup.py install for psutil 11:08:50 INFO - building 'psutil._psutil_linux' extension 11:08:50 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 11:08:50 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 11:08:51 INFO - building 'psutil._psutil_posix' extension 11:08:51 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 11:08:51 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 11:08:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:51 INFO - Successfully installed psutil 11:08:51 INFO - Cleaning up... 11:08:51 INFO - Return code: 0 11:08:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:08:51 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')]} 11:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:51 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')]} 11:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:51 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:08:51 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 11:08:51 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 11:08:51 INFO - Using env: {'DISPLAY': ':0', 11:08:51 INFO - 'HOME': '/home/cltbld', 11:08:51 INFO - 'LANG': 'en_US.UTF-8', 11:08:51 INFO - 'LANGUAGE': 'en_US:en', 11:08:51 INFO - 'LOGNAME': 'cltbld', 11:08:51 INFO - 'MAIL': '/var/mail/cltbld', 11:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:51 INFO - 'MOZ_NO_REMOTE': '1', 11:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:51 INFO - 'NO_EM_RESTART': '1', 11:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:51 INFO - 'SHELL': '/bin/bash', 11:08:51 INFO - 'SHLVL': '1', 11:08:51 INFO - 'TERM': 'linux', 11:08:51 INFO - 'TMOUT': '86400', 11:08:51 INFO - 'USER': 'cltbld', 11:08:51 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:51 INFO - '_': '/tools/buildbot/bin/python'} 11:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:08:53 INFO - Installing collected packages: mozsystemmonitor 11:08:53 INFO - Running setup.py install for mozsystemmonitor 11:08:53 INFO - Successfully installed mozsystemmonitor 11:08:53 INFO - Cleaning up... 11:08:53 INFO - Return code: 0 11:08:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:08: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')]} 11:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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', '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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:08: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:08: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 blobuploader==1.2.4 11:08:53 INFO - Using env: {'DISPLAY': ':0', 11:08:53 INFO - 'HOME': '/home/cltbld', 11:08:53 INFO - 'LANG': 'en_US.UTF-8', 11:08:53 INFO - 'LANGUAGE': 'en_US:en', 11:08:53 INFO - 'LOGNAME': 'cltbld', 11:08:53 INFO - 'MAIL': '/var/mail/cltbld', 11:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:53 INFO - 'MOZ_NO_REMOTE': '1', 11:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:53 INFO - 'NO_EM_RESTART': '1', 11:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:53 INFO - 'SHELL': '/bin/bash', 11:08:53 INFO - 'SHLVL': '1', 11:08:53 INFO - 'TERM': 'linux', 11:08:53 INFO - 'TMOUT': '86400', 11:08:53 INFO - 'USER': 'cltbld', 11:08:53 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:53 INFO - '_': '/tools/buildbot/bin/python'} 11:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08: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 11:08:55 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:08:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08:55 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 11:08:55 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 11:08:55 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 11:08:55 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 11:08:55 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 11:08:55 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 11:08:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:08:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:08:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:55 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 11:08:55 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 11:08:55 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 11:08:55 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 11:08:55 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 11:08:55 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 11:08:56 INFO - Downloading docopt-0.6.1.tar.gz 11:08:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:56 INFO - Running setup.py install for blobuploader 11:08:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:08:56 INFO - Running setup.py install for requests 11:08:56 INFO - Running setup.py install for docopt 11:08:56 INFO - Successfully installed blobuploader requests docopt 11:08:56 INFO - Cleaning up... 11:08:56 INFO - Return code: 0 11:08:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:08: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')]} 11:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:56 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:08:56 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 11:08:56 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 11:08:56 INFO - Using env: {'DISPLAY': ':0', 11:08:56 INFO - 'HOME': '/home/cltbld', 11:08:56 INFO - 'LANG': 'en_US.UTF-8', 11:08:56 INFO - 'LANGUAGE': 'en_US:en', 11:08:56 INFO - 'LOGNAME': 'cltbld', 11:08:56 INFO - 'MAIL': '/var/mail/cltbld', 11:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:56 INFO - 'MOZ_NO_REMOTE': '1', 11:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:56 INFO - 'NO_EM_RESTART': '1', 11:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:08:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:08:56 INFO - 'SHELL': '/bin/bash', 11:08:56 INFO - 'SHLVL': '1', 11:08:56 INFO - 'TERM': 'linux', 11:08:56 INFO - 'TMOUT': '86400', 11:08:56 INFO - 'USER': 'cltbld', 11:08:56 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:56 INFO - '_': '/tools/buildbot/bin/python'} 11:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:08:57 INFO - Running setup.py (path:/tmp/pip-1S0i83-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:08:57 INFO - Running setup.py (path:/tmp/pip-srj5Ia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:08:57 INFO - Running setup.py (path:/tmp/pip-ijqr9j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:08:57 INFO - Running setup.py (path:/tmp/pip-hB7VMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:08:57 INFO - Running setup.py (path:/tmp/pip-QZHcld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:08:57 INFO - Running setup.py (path:/tmp/pip-grxVlV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:08:57 INFO - Running setup.py (path:/tmp/pip-RiNZrD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:08:57 INFO - Running setup.py (path:/tmp/pip-v9wJh6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:08:57 INFO - Running setup.py (path:/tmp/pip-_ieDND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:08:57 INFO - Running setup.py (path:/tmp/pip-RZYKGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:08:57 INFO - Running setup.py (path:/tmp/pip-28XON8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:08:57 INFO - Running setup.py (path:/tmp/pip-PnJc5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:08:57 INFO - Running setup.py (path:/tmp/pip-EQiNYd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:08:57 INFO - Running setup.py (path:/tmp/pip-XJnexr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:08:58 INFO - Running setup.py (path:/tmp/pip-fwpPKG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:08:58 INFO - Running setup.py (path:/tmp/pip-MKUmhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:08:58 INFO - Running setup.py (path:/tmp/pip-Ais9zW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:08:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:58 INFO - Running setup.py install for manifestparser 11:08:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:08:58 INFO - Running setup.py install for mozcrash 11:08:58 INFO - Running setup.py install for mozdebug 11:08:58 INFO - Running setup.py install for mozdevice 11:08:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:08:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:08:58 INFO - Running setup.py install for mozfile 11:08:58 INFO - Running setup.py install for mozhttpd 11:08:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:08:58 INFO - Running setup.py install for mozinfo 11:08:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:08:58 INFO - Running setup.py install for mozInstall 11:08:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Running setup.py install for mozleak 11:08:59 INFO - Running setup.py install for mozlog 11:08:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Running setup.py install for moznetwork 11:08:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Running setup.py install for mozprocess 11:08:59 INFO - Running setup.py install for mozprofile 11:08:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Running setup.py install for mozrunner 11:08:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:08:59 INFO - Running setup.py install for mozscreenshot 11:08:59 INFO - Running setup.py install for moztest 11:08:59 INFO - Running setup.py install for mozversion 11:08:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:09:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:00 INFO - Cleaning up... 11:09:00 INFO - Return code: 0 11:09:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:00 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:09:00 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 11:09:00 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 11:09:00 INFO - Using env: {'DISPLAY': ':0', 11:09:00 INFO - 'HOME': '/home/cltbld', 11:09:00 INFO - 'LANG': 'en_US.UTF-8', 11:09:00 INFO - 'LANGUAGE': 'en_US:en', 11:09:00 INFO - 'LOGNAME': 'cltbld', 11:09:00 INFO - 'MAIL': '/var/mail/cltbld', 11:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:00 INFO - 'MOZ_NO_REMOTE': '1', 11:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:00 INFO - 'NO_EM_RESTART': '1', 11:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:09:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:09:00 INFO - 'SHELL': '/bin/bash', 11:09:00 INFO - 'SHLVL': '1', 11:09:00 INFO - 'TERM': 'linux', 11:09:00 INFO - 'TMOUT': '86400', 11:09:00 INFO - 'USER': 'cltbld', 11:09:00 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:00 INFO - '_': '/tools/buildbot/bin/python'} 11:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:09:00 INFO - Running setup.py (path:/tmp/pip-tQ4Inx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:09:00 INFO - Running setup.py (path:/tmp/pip-MkCgTM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:09:00 INFO - Running setup.py (path:/tmp/pip-9YZj33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:09:00 INFO - Running setup.py (path:/tmp/pip-a4OOKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:09:00 INFO - Running setup.py (path:/tmp/pip-YY9f14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:09:00 INFO - Running setup.py (path:/tmp/pip-onv1Hl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:09:00 INFO - Running setup.py (path:/tmp/pip-6GVZ9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:09:00 INFO - Running setup.py (path:/tmp/pip-YWcE20-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:09:00 INFO - Running setup.py (path:/tmp/pip-Ic5NdF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:09:00 INFO - Running setup.py (path:/tmp/pip-Z4bDGa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:09:00 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)) 11:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:09:00 INFO - Running setup.py (path:/tmp/pip-rEf2q7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:09:01 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)) 11:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:09:01 INFO - Running setup.py (path:/tmp/pip-RF6OPR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:09:01 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)) 11:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:09:01 INFO - Running setup.py (path:/tmp/pip-WSkltB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:09:01 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)) 11:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:09:01 INFO - Running setup.py (path:/tmp/pip-ksQYve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:09:01 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)) 11:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:09:01 INFO - Running setup.py (path:/tmp/pip-Qfqjuo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:09:01 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)) 11:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:09:01 INFO - Running setup.py (path:/tmp/pip-ydT62_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:09:01 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)) 11:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:09:01 INFO - Running setup.py (path:/tmp/pip-K6ulU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:09:01 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)) 11:09:01 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)) 11:09:01 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)) 11:09:01 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)) 11:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:09:01 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)) 11:09:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:03 INFO - Downloading blessings-1.5.1.tar.gz 11:09:03 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 11:09:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:03 INFO - Installing collected packages: blessings 11:09:03 INFO - Running setup.py install for blessings 11:09:03 INFO - Successfully installed blessings 11:09:03 INFO - Cleaning up... 11:09:03 INFO - Return code: 0 11:09:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:09:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:09:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:09:03 INFO - Reading from file tmpfile_stdout 11:09:03 INFO - Current package versions: 11:09:03 INFO - argparse == 1.2.1 11:09:03 INFO - blessings == 1.5.1 11:09:03 INFO - blobuploader == 1.2.4 11:09:03 INFO - docopt == 0.6.1 11:09:03 INFO - manifestparser == 1.1 11:09:03 INFO - mozInstall == 1.12 11:09:03 INFO - mozcrash == 0.16 11:09:03 INFO - mozdebug == 0.1 11:09:03 INFO - mozdevice == 0.47 11:09:03 INFO - mozfile == 1.2 11:09:03 INFO - mozhttpd == 0.7 11:09:03 INFO - mozinfo == 0.9 11:09:03 INFO - mozleak == 0.1 11:09:03 INFO - mozlog == 3.1 11:09:03 INFO - moznetwork == 0.27 11:09:03 INFO - mozprocess == 0.22 11:09:03 INFO - mozprofile == 0.27 11:09:03 INFO - mozrunner == 6.11 11:09:03 INFO - mozscreenshot == 0.1 11:09:03 INFO - mozsystemmonitor == 0.0 11:09:03 INFO - moztest == 0.7 11:09:03 INFO - mozversion == 1.4 11:09:03 INFO - psutil == 3.1.1 11:09:03 INFO - requests == 1.2.3 11:09:03 INFO - wsgiref == 0.1.2 11:09:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:03 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:09:03 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 11:09:03 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 11:09:03 INFO - Using env: {'DISPLAY': ':0', 11:09:03 INFO - 'HOME': '/home/cltbld', 11:09:03 INFO - 'LANG': 'en_US.UTF-8', 11:09:03 INFO - 'LANGUAGE': 'en_US:en', 11:09:03 INFO - 'LOGNAME': 'cltbld', 11:09:03 INFO - 'MAIL': '/var/mail/cltbld', 11:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:03 INFO - 'MOZ_NO_REMOTE': '1', 11:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:03 INFO - 'NO_EM_RESTART': '1', 11:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:09:03 INFO - 'PWD': '/builds/slave/test-pgo', 11:09:03 INFO - 'SHELL': '/bin/bash', 11:09:03 INFO - 'SHLVL': '1', 11:09:03 INFO - 'TERM': 'linux', 11:09:03 INFO - 'TMOUT': '86400', 11:09:03 INFO - 'USER': 'cltbld', 11:09:03 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:03 INFO - '_': '/tools/buildbot/bin/python'} 11:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 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)) 11:09:03 INFO - Cleaning up... 11:09:03 INFO - Return code: 0 11:09:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:03 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:09:03 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 11:09:03 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 11:09:03 INFO - Using env: {'DISPLAY': ':0', 11:09:03 INFO - 'HOME': '/home/cltbld', 11:09:03 INFO - 'LANG': 'en_US.UTF-8', 11:09:03 INFO - 'LANGUAGE': 'en_US:en', 11:09:03 INFO - 'LOGNAME': 'cltbld', 11:09:03 INFO - 'MAIL': '/var/mail/cltbld', 11:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:03 INFO - 'MOZ_NO_REMOTE': '1', 11:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:03 INFO - 'NO_EM_RESTART': '1', 11:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:09:03 INFO - 'PWD': '/builds/slave/test-pgo', 11:09:03 INFO - 'SHELL': '/bin/bash', 11:09:03 INFO - 'SHLVL': '1', 11:09:03 INFO - 'TERM': 'linux', 11:09:03 INFO - 'TMOUT': '86400', 11:09:03 INFO - 'USER': 'cltbld', 11:09:03 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:03 INFO - '_': '/tools/buildbot/bin/python'} 11:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:04 INFO - Downloading/unpacking jsonschema 11:09:04 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 11:09:04 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 11:09:04 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 11:09:04 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 11:09:04 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 11:09:04 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 11:09:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:05 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 11:09:05 INFO - Downloading/unpacking functools32 (from jsonschema) 11:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:09:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:06 INFO - warning: no files found matching '*.txt' 11:09:06 INFO - no previously-included directories found matching 'build' 11:09:06 INFO - no previously-included directories found matching 'dist' 11:09:06 INFO - no previously-included directories found matching '.git*' 11:09:06 INFO - Installing collected packages: jsonschema, functools32 11:09:06 INFO - Running setup.py install for functools32 11:09:06 INFO - warning: no files found matching '*.txt' 11:09:06 INFO - no previously-included directories found matching 'build' 11:09:06 INFO - no previously-included directories found matching 'dist' 11:09:06 INFO - no previously-included directories found matching '.git*' 11:09:06 INFO - Successfully installed jsonschema functools32 11:09:06 INFO - Cleaning up... 11:09:06 INFO - Return code: 0 11:09:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:06 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 0x7f7e1b9e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, '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': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', '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 11:09:06 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 11:09:06 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 11:09:06 INFO - Using env: {'DISPLAY': ':0', 11:09:06 INFO - 'HOME': '/home/cltbld', 11:09:06 INFO - 'LANG': 'en_US.UTF-8', 11:09:06 INFO - 'LANGUAGE': 'en_US:en', 11:09:06 INFO - 'LOGNAME': 'cltbld', 11:09:06 INFO - 'MAIL': '/var/mail/cltbld', 11:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:06 INFO - 'MOZ_NO_REMOTE': '1', 11:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:06 INFO - 'NO_EM_RESTART': '1', 11:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:09:06 INFO - 'SHELL': '/bin/bash', 11:09:06 INFO - 'SHLVL': '1', 11:09:06 INFO - 'TERM': 'linux', 11:09:06 INFO - 'TMOUT': '86400', 11:09:06 INFO - 'USER': 'cltbld', 11:09:06 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:06 INFO - '_': '/tools/buildbot/bin/python'} 11:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:06 INFO - Downloading/unpacking flake8 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:09:08 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 11:09:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:09:08 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 11:09:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:08 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 11:09:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09: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 11:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:09:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:08 INFO - no previously-included directories found matching 'docs/_build' 11:09:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:09:08 INFO - Running setup.py install for pep8 11:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:08 INFO - no previously-included directories found matching 'docs/_build' 11:09:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:09:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:09:08 INFO - Cleaning up... 11:09:09 INFO - Return code: 0 11:09:09 INFO - Running post-action listener: _resource_record_post_action 11:09:09 INFO - Running post-action listener: _start_resource_monitoring 11:09:09 INFO - Starting resource monitoring. 11:09:09 INFO - ##### 11:09:09 INFO - ##### Running install step. 11:09:09 INFO - ##### 11:09:09 INFO - Running pre-action listener: _resource_record_pre_action 11:09:09 INFO - Running main action method: install 11:09:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:09:09 INFO - Reading from file tmpfile_stdout 11:09:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:09:09 INFO - Reading from file tmpfile_stdout 11:09:09 INFO - Output received: 11:09:09 INFO - Usage: mozinstall [options] installer 11:09:09 INFO - Options: 11:09:09 INFO - -h, --help show this help message and exit 11:09:09 INFO - -d DEST, --destination=DEST 11:09:09 INFO - Directory to install application into. [default: 11:09:09 INFO - "/builds/slave/test-pgo"] 11:09:09 INFO - --app=APP Application being installed. [default: firefox] 11:09:09 INFO - mkdir: /builds/slave/test-pgo/build/application 11:09:09 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'] 11:09:09 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 11:09:25 INFO - Reading from file tmpfile_stdout 11:09:25 INFO - Output received: 11:09:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:09:25 INFO - Running post-action listener: _resource_record_post_action 11:09:25 INFO - ##### 11:09:25 INFO - ##### Running run-tests step. 11:09:25 INFO - ##### 11:09:25 INFO - Running pre-action listener: _resource_record_pre_action 11:09:25 INFO - Running main action method: run_tests 11:09:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:09:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:09:25 INFO - Python 2.7.3 11:09:25 INFO - Return code: 0 11:09:25 INFO - grabbing minidump binary from tooltool 11:09:25 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')]} 11:09:25 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 0x19ca350>, '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 0x19cb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cb6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:09:25 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 11:09:25 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 11:09:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:25 INFO - Return code: 0 11:09:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:09:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:09:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:09:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:09:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:09:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:09:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:09:26 INFO - Return code: 0 11:09:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:09:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost 11:09:26 INFO - Using env: {'DISPLAY': ':0', 11:09:26 INFO - 'HOME': '/home/cltbld', 11:09:26 INFO - 'LANG': 'en_US.UTF-8', 11:09:26 INFO - 'LANGUAGE': 'en_US:en', 11:09:26 INFO - 'LOGNAME': 'cltbld', 11:09:26 INFO - 'MAIL': '/var/mail/cltbld', 11:09:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:09:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:26 INFO - 'MOZ_NO_REMOTE': '1', 11:09:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:26 INFO - 'NO_EM_RESTART': '1', 11:09:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:09:26 INFO - 'PWD': '/builds/slave/test-pgo', 11:09:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:09:26 INFO - 'SHELL': '/bin/bash', 11:09:26 INFO - 'SHLVL': '1', 11:09:26 INFO - 'TERM': 'linux', 11:09:26 INFO - 'TMOUT': '86400', 11:09:26 INFO - 'USER': 'cltbld', 11:09:26 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062', 11:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:26 INFO - '_': '/tools/buildbot/bin/python'} 11:09:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] with output_timeout 3600 11:09:26 INFO - mozversion INFO | application_buildid: 20151217083216 11:09:26 INFO - mozversion INFO | application_changeset: 327f0142e1a78bef241999e9679a357e75ff9698 11:09:26 INFO - mozversion INFO | application_display_name: Nightly 11:09:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:26 INFO - mozversion INFO | application_name: Firefox 11:09:26 INFO - mozversion INFO | application_remotingname: firefox 11:09:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:09:26 INFO - mozversion INFO | application_vendor: Mozilla 11:09:26 INFO - mozversion INFO | application_version: 46.0a1 11:09:26 INFO - mozversion INFO | platform_buildid: 20151217083216 11:09:26 INFO - mozversion INFO | platform_changeset: 327f0142e1a78bef241999e9679a357e75ff9698 11:09:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:26 INFO - mozversion INFO | platform_version: 46.0a1 11:09:26 INFO - 2015-12-17 11:09:26,578 DEBUG : using testdate: 1450379366 11:09:26 INFO - 2015-12-17 11:09:26,578 DEBUG : actual date: 1450379366 11:09:26 INFO - 2015-12-17 11:09:26,629 INFO : starting webserver on 'localhost:50887' 11:09:26 INFO - 2015-12-17 11:09:26,630 INFO : Starting test suite talos-linux64-ix-006 11:09:26 INFO - 2015-12-17 11:09:26,630 INFO : Starting test dromaeo_css 11:09:26 INFO - 2015-12-17 11:09:26,630 DEBUG : operating with platform_type : linux_ 11:09:26 INFO - 2015-12-17 11:09:26,631 INFO : Initialising browser for dromaeo_css test... 11:09:26 INFO - 2015-12-17 11:09:26,656 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnTecKA/profile http://localhost:50887/getInfo.html 11:09:31 INFO - 2015-12-17 11:09:31,839 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:09:31 INFO - 2015-12-17 11:09:31,840 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:09:31 INFO - 2015-12-17 11:09:31,840 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:09:31 INFO - 2015-12-17 11:09:31,840 DEBUG : BROWSER_OUTPUT: __metrics 11:09:31 INFO - 2015-12-17 11:09:31,928 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] 11:09:31 INFO - 2015-12-17 11:09:31,976 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] 11:09:33 INFO - 2015-12-17 11:09:33,076 INFO : Browser initialized. 11:09:33 INFO - 2015-12-17 11:09:33,076 INFO : Running cycle 1/1 for dromaeo_css test... 11:09:33 INFO - 2015-12-17 11:09:33,077 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnTecKA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:09:44 INFO - 2015-12-17 11:09:44,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 149573632 11:09:44 INFO - 2015-12-17 11:09:44,992 DEBUG : BROWSER_OUTPUT: 11:10:36 INFO - 2015-12-17 11:10:36,566 DEBUG : BROWSER_OUTPUT: 1450379436562 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] 11:12:45 INFO - 2015-12-17 11:12:45,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50887/tests/dromaeo/cssquery-ext.html) 11:12:46 INFO - 2015-12-17 11:12:46,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 269492224 11:12:46 INFO - 2015-12-17 11:12:46,592 DEBUG : BROWSER_OUTPUT: 11:15:48 INFO - 2015-12-17 11:15:48,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/dromaeo/cssquery-ext.html (next: http://localhost:50887/tests/dromaeo/cssquery-jquery.html) 11:15:49 INFO - 2015-12-17 11:15:49,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 236802048 11:15:49 INFO - 2015-12-17 11:15:49,562 DEBUG : BROWSER_OUTPUT: 11:18:51 INFO - 2015-12-17 11:18:51,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50887/tests/dromaeo/cssquery-mootools.html) 11:18:51 INFO - 2015-12-17 11:18:51,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 228020224 11:18:51 INFO - 2015-12-17 11:18:51,990 DEBUG : BROWSER_OUTPUT: 11:21:53 INFO - 2015-12-17 11:21:53,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50887/tests/dromaeo/cssquery-prototype.html) 11:21:54 INFO - 2015-12-17 11:21:54,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 215977984 11:21:54 INFO - 2015-12-17 11:21:54,409 DEBUG : BROWSER_OUTPUT: 11:24:56 INFO - 2015-12-17 11:24:56,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50887/tests/dromaeo/cssquery-yui.html) 11:24:57 INFO - 2015-12-17 11:24:57,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 218783744 11:24:57 INFO - 2015-12-17 11:24:57,451 DEBUG : BROWSER_OUTPUT: 11:27:59 INFO - 2015-12-17 11:27:59,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/dromaeo/cssquery-yui.html (next: http://localhost:50887/tests/dromaeo/cssquery-dojo.html) 11:28:00 INFO - 2015-12-17 11:28:00,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 268775424 11:28:00 INFO - 2015-12-17 11:28:00,218 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,218 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:28:00 INFO - 2015-12-17 11:28:00,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:28:00 INFO - 2015-12-17 11:28:00,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:28:00 INFO - 2015-12-17 11:28:00,218 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:28:00 INFO - 2015-12-17 11:28:00,218 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3139.7174254317106;3182.9204269893235;3186.187522181843;3228.999010306805;3249.1227368610466;5125.589952803776;5231.607629427789;5318.654287471317;5406.729663516828;5440.6191566590305;5226.660267082637;5228.633995620308;5278.26104345391;5327.653702509344;5332.600054995872;4795.976020119903;4797.184478638623;4824.734639594821;4845;4891.339669144673;4514.345419914111;4896.46138924718;4943.233798761198;4952.281919121725;4988.600911927056;4689.671722979393;4729.929051064237;4798.448178459487;4907.582855457291;4910.484399138093;4827.106985207713;4850;4858.29554714568;4863.197572400585;4883.755812209375;4822.324874517571;4838.637102217348;4842.104210720992;4849.321095046696;4862.367892173995;4968.30443737877;5039.3196918415915;5047.116754567973;5223.686578805284;5227.085260079509;5668.68822214778;5748.223989761371;5749.453801888814;5756.625819321731;5802.12968054791;5779.624324418899;5782.681952492611;5784.797532086399;5786.594938354317;5792.855178620526;5182.922256166161;5286.07493688603;5288.021715982517;5398.973005134989;5402.405735369106;5766.481016708432;5883.205767221456;5889.352171261158;5928.644281343133;5937.079752638261;5615.8596035098635;5618.157276408571;5618.2415373924;5621.634593751393;5667.829965101054;5552.444755524496;5705.74324155414;5712.6001179917;5714.685692286881;5724.627899186539;5664.2636457261115;5723.942760572424;5762.078067509178;5782.45066718661;5805.506531944748;5692.7722891083895;5693.28833895763;5693.4021927696995;5699.344575373885;5716.9142462862255;4333.046729719456;4372.8906777330185;4417.757023363682;4425.203463376559;4451.109778044404;3927.4697915781576;3956.643902048772;3971.5234171899556;3987.6211759882763;3989.4215338776294;5334.1732031535175;5350.27771250884;5350.384705758887;5352.759125839347;5359.517643412034;5697.316322041382;5733.827985160368;5813.5349172066135;5817.214676018768;5821.214136091573;5336.91994620081;5381.112116500812;5383.946160538345;5387.757550910218;5390.9191362129595;5013.298138260647;5020.196768517019;5024.824131155392;5027.296178535008;5061.038402703474;5665.943340566541;5706.172604972338;5795.246617939725;5811.912821307684;5819.214406055213;5650.717464126859;5692.48767610917;5706.087026075808;5710.486056254957;5724.084146536534;5725.198472213977;5726.914096288476;5751.079827227623;5764.394738552392;5767.913481297868;5471.671699698031;5569.944300556943;5582.720863956867;5584.078627026495;5618.353889302783;5642.802501912413;5647.322321321468;5678.716064196691;5699.51554117888;5714.171445140514;5510.173473978935;5513.3108361454815;5516.420775818481;5526.088195447706;5533.916991245215;5409.404965453876;5476.17857321405;5509.090999985118;5517.282753242213;5560.6107572471155;5412.621116521806;5442.700651464207;5519.2824932758485;5533.253010843485;5564.888702226014;5531.419200984;5532.5020748132865;5544.833654990357;5594.720263986866;5606.831795046155;5313.149896016619;5425.864353391197;5426.67439953604;5427.4301198373605;5435.103207970798 11:28:00 INFO - 2015-12-17 11:28:00,219 DEBUG : BROWSER_OUTPUT: |1;ext.html;583.6439771739235;586.311084475741;587.8794847056354;587.9323877754058;614.2536817766415;29727.851360743192;31062.37875242494;31064.53403198951;37901.43147852785;38297.808510957475;42675;42863.35704964428;42935.78532107343;43037.78481107598;43226.351604725955;8427.452215605981;8702.390832641686;8703.129687031309;8704.389687907757;8708.521031343274;7606.733764318223;7753.651085701157;10305.38167709936;10496.845347011822;10503.684889453329;10106.191504679644;10189.490525473733;10246.436445995467;10247.333923294998;10266.691999240034;7591.354734847489;7753.18591547885;9917.206623470141;9992.250581206403;9997.100260976475;10270.281080324381;10489.318194317346;10489.842652360221;10504.842427363596;10518.526666300035;38956.80521597374;39613.850199474175;39652.40521392181;39678.404823927376;39699.8015009926;3130.8591113399953;3276.918077048069;3411.9147021324666;3519.7008254298416;3818.770873747584;30099.247518811986;30603.387932241232;30739.538906916416;30753.231169220726;31223.531647025313;3910.1006768443135;4020.1155745736182;4050.858219962287;4073.226087043482;4146.274401979672;260029;260736;261270;261274;262084;58757.41242587605;59124.70437647784;59690.701546492855;59693;59696.40303596995;60669.39330606726;62005.37994620086;63378.36621633724;63640.36359636437;63906.36093639097;14217.004809663431;16034.679306413806;16505.17474126289;16520.586985325463;16535.338586456408;11458.484368203452;11476.942615286871;11605.477753501113;11623.6512904613;11627.88372116268;19361.612767744566;19368.612627747367;19399.709004364664;19410.320638777575;19412.805871941382;7493.85012299751;7741.148473667892;7763.805904852424;7828.569428681477;7878.960605196938;801.418971245842;909.8225845960106;934.756963189562;938.9812203755887;1058.6823952814125;27388.726112739016;27463.450730985267;27644.58533122005;27871;27874.5818812718;1000.1348833259178;1016.8271393863062;1026.6560702164709;1090.4929207918356;1092.4100985467917;14222.431102755982;16290.83709162917;16674.166291685367;16674.58218558302;16721.16394180286;385977;390333;390602;391340;391668;52286;52600.473995259556;52767.47232527703;52814;52932.73533632307;1278.9424475898606;1284.9614511564669;1301.5054279373967;1306.8497122830995;1309.2537253765454;28687.139385817623;29015.56476652894;29225;29715.851420742758;29737.25656858596;40895.1820963585;41691.1661766769;44911;45460;45783.77108114438;244768;244793;247023;247412;247757;30481.695183047887;30731.692683072884;30732.539011915287;30859.69140308658;31181.8440907794;33902.32195356128;41307.38038929358;41666.375004375564;41807.790961045;42632.360514592925;32782.672173278916;32879;33269.334613308085;33702.49446258357;33868.49197262093;40163.598364017154;41248;41447.792761036;41659.7917010413;42561.36157957695;35612.28775424529;35718.64281357153;35822.8208858954;38245.617543824206;38844.95015647948;30319.696803031686;32149.196270093435;32624.184395390304;32645.510317345736;32725.181870452478;24231.636525452486;24709.135180268604;24731.381715457257;25170.37074073163;25220 11:28:00 INFO - 2015-12-17 11:28:00,219 DEBUG : BROWSER_OUTPUT: |2;jquery.html;349.13240597116163;350.8666706651472;351.35526309222575;351.6114693263945;351.68699857127154;13690.931545342284;14014.159150450954;16138.677226455478;16427.50717478476;17391.304347826073;15784.131872747022;15906.840931590681;16956.576085597866;17012.744808827847;17017.74473382897;4279.999999999992;4451.666125040619;4452.955470445303;4453.064856380164;4459.331100334944;3771.641694039062;3840.3855383138703;3879.9806000970098;4431.1802316571375;5933.5549833762425;5913.763449462016;5942.197803296543;5945.583809133363;5949.405059494037;5957.2851257849115;5787.33445653751;5892.057270836688;5923.792667256647;5923.970380148115;5931.822045338604;5215.035218484592;5220.8694782630355;5228.686278823283;5229.50319719626;5230.503102205323;18101.7284740729;18424.815751842445;18962.71555926662;20241;20251.189952401885;1649.364994477123;1830.8993005384698;1840.6962851129547;2019.4547472182576;2039.7246371739923;9008.099190081006;9176;9430.434173949585;9515.905670847802;11702.707432314175;1497.4010395841642;1657.7109881705624;1672.9962022786353;1720.4924547258588;1849.3527265456983;59483;62302.68848655773;63356.68321658454;63667.36332636707;64242.3575764241;9953.606495090693;9960.402375857471;10007.14939230159;10026.298159128937;10088.596456141819;13280;13297;13329.533466328632;13353.66615834612;13364.331783410791;7485.438592105614;7487.1764105948305;7504.849903001909;7543.7736867894055;7639.656215470317;7253.56478611285;7298.124225093023;7313;7369.447291453055;7388.741394051182;4235.7035007549175;4311.698181127354;4350.521442641307;4380.934285985712;4434.357018232338;1713.092061207562;1735.0804073840884;1739.3042782886946;1757.6221112460883;1765.2321240260271;801.4750338528273;845.9492430454069;905.3391024552113;922.2207234886511;973.7176218896583;15630.374785008473;16200.351985920666;16852.831471685127;16930.746038809426;17210;813.9674413023531;933.3513208320288;959.8896126945491;962.0043255230803;978.8678528398717;8664.393492455594;9096.81806363869;9097.454152750855;9114.954425227965;9223.354365194506;558038;559787;560244.1865697426;567854;574404;77740.61129694316;78135;79716;80432;83552;1125.763589646167;1127.937963412004;1189.5503041180473;1190.4047976011993;1200.237848965913;14425;14523.78214326807;14638.853611463748;14740.11559306445;14964;31974.200644984063;32589.511157333134;32653.346933061683;32817.50773738348;32966.175845604055;46055.078898422515;47385;47902.520974789804;48585.271220931005;50664.74667626786;9383.671571494964;9430.764230894283;9590.472524010967;9693.660721874701;9825.557849896915;16510.917445412695;16643.750343745094;16944.57638559046;17451.738223926906;17555.736663949796;14258.073225240327;14316.427342906167;14374.640633983816;14590.416383344971;14938.402463901757;13899.583012509642;13955;14022.579322620337;14568.49010284635;14742.189179595225;11861.762764744484;14609.269536523343;14684;14800.111993280438;15248.237588120772;7824.64789084504;9211.355205135576;9240.306976976888;9371.578278977326;9375.249980001447;13982;14500.637484062983;14511.346989385715;14673.779893301822;14741.262936853329 11:28:00 INFO - 2015-12-17 11:28:00,220 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1323.9205647661136;1469.963250918727;1529.9082055076692;1645.7942757155356;1777.6355847051357;6548.27968923418;7100.396466300364;7189.388901943328;7205.459590530718;7222.711091556338;7117.145942486909;7302.3427891489755;7314.451416143797;7336.449766267538;7359.889601655979;1837.2834594508151;1873.363056560769;1874.7000479923215;2090.822280106189;2131.4777879419485;2091.059023439451;2121.2151503943564;2133.605283022646;2136.508603021306;2139.1443422630996;2034.9796502034937;2035.4632252649303;2046.9969714839697;2047.6109539187507;2050.9847625425436;2047.6723724204205;2064.0505367530955;2079.105984426696;2079.261862038977;2079.979200208009;2040.1125510402874;2059.032254840223;2065.31844491319;2066.8243199328076;2067.4831292176955;7175.354218120342;7211.675474603603;7212.3869471094495;7255.201927787992;7280;4346.239408103569;4425.668074894364;4427.623651989585;4428.822847086113;4467.865964021052;2915.650121985354;3000.744936680385;3021.4108248891475;3027.1372658792357;3037.817730936151;960.3805545423232;966.2318456826839;971.6696323250129;995.382862625177;1000.9249306302056;10059.849102263472;10064.144547713453;10071.597136114546;10071.949640251825;10080.647177348757;4023.4970628671417;4032.3749818778138;4085.0604360996545;4086.1010577672864;4088.6115818997146;8576.099509551532;8635.740927772176;8638.784030399165;8649.394542382099;8690.869636955451;4458.71018383804;4481.596656300883;4491.101779644085;4493.640508759291;4515.322701594787;4092.897677558085;4128.587141285848;4133.7106402551535;4147.108371700038;4150.315197992298;3125.4374212641487;3136.2943337748825;3173.9682603174133;3426.0920855973186;3437.7077948374667;1065.722912042859;1066.4507778494083;1068.5458680060942;1071.3839542263229;1073.6564299424265;1025.887152413234;1030.2427715629008;1074.08166018055;1165.8600967883908;1318.2815365625756;6929.064576282238;6943.444524438033;6964.408025317804;7013.684384202723;7037.92962070383;1089.8310761831929;1105.4417519152776;1114.2200459678259;1121.9439028048564;1136.9488373023235;5413.621046526784;5523.143912693539;5532.474414930575;5543.1408131739645;5543.974364742536;8160.102388737234;8338.583070846433;8356.582170891432;8455.154484551496;8476.279516241066;8299.95850020746;8385.496870187808;8399.580020998925;8403.915960840435;8406.285465735358;6852.314768523108;6876.931230687729;6965.895511567331;7054.2945705430075;7075.893861592081;6886.965565172142;6897.517173797786;6937.791866244021;6955;6962.060121883481;7759.379249659901;7844.254795794391;7905.446618736633;7913.406494513049;7986.800329991796;7901.525908445512;8183.631736571988;8186.2632363087605;8195.83608327842;8218.58907054633;6469.547131700736;6476.222853257639;6479.708413121327;6536.084948107174;6541.34586541342;6327.462165715966;6449.709763060768;6878.55289406187;7072.115985501812;7154.928450715634;6583.341665833378;6651.401373876374;6671.8999215010845;6703.93296067033;6792.898106528505;6436.549441539048;6455.096286519797;6482.481401487964;6523.7716679915975;6550.901736474052;6524.4780417565535;6567.638779867153;6579.572327798678;6582.76960306387;6593.142891424084;6203.286622038523;6224.439800417984;6227.034809604518;6235.594686345373;6244.812655620339;6124.601900876429;6145.201123853871;6149.7847575334645;6171.259448866164;6286.308506064238 11:28:00 INFO - 2015-12-17 11:28:00,221 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.71634245521483;327.44007746753056;327.5545258448511;331.7594743810739;337.68932582024536;5916.437938395851;5950.940490595092;5957.374475680045;5967.134765459005;5996.550258730596;5815.47660710536;5854.268216472941;5855.912161317573;5857.033589457735;5873.676947767871;4513.345564893097;4521.5930566249035;4522.819087236507;4526.275795872661;4528.162289976365;4384.758838263894;4473.373727678128;4517.232070547998;4526.524714904937;4532.592066713995;4395.472543294809;4399.86800395987;4402.713823601472;4410.448693913261;4467.084247729208;4229.6827737919775;4405.1850407674365;4409.096135292273;4413.977930110345;4419.469663640351;3772;3772.622737726233;3833.9839942415283;3850.191459793447;3887.028242939265;5564;5564.221009058735;5570.637908535973;5571.721413929328;5592.832215033555;4945.406551213841;5087.923681144785;5179.456157103487;5199.272101905736;5200.8959820803375;6102.8779424411705;6120.96939515304;6191.597546159485;6196.946519091765;6205.844853878644;4262.211490874167;4262.232798096342;4266.1254442839145;4267.487901451846;4273.807678654437;6379.649119298437;6445.93554064458;6447.935520644827;6448.774292899773;6451.58064725796;4285.957140428618;4355.847545335898;4365.585269399466;4372.475302963601;4384.342348647729;4424.911501769947;4428.070105277863;4428.557144285545;4428.933565996513;4429.579189976947;5163.096458119814;5170.5346518813485;5175.404828444702;5177.767000484987;5194.896102077937;6151.569390142647;6283.560150789401;6292.716827742763;6307.400796924285;6321;1554.8289688134296;1564.6714190020223;1570.8350623184629;1571.2222449887379;1571.693519763658;1033.194108595297;1050.2858056521638;1053.5891002509027;1054.1040115901421;1066.8826429092794;5969.194158788595;5974.880502390015;5975.133605627159;5983.910241346383;5995.400459953969;6461.418472337512;6463.515236357292;6466.935330646634;6475.384838440341;6481.805545833632;5958.463738263577;5960.970195148997;5963.135345374896;5966.85082872923;5968.283805943314;3408.6761757632985;3494.4758286257265;3494.8602055917986;3495.9300813983577;3503.2818272254126;6599.868002639921;6599.9010014848855;6608.603483790988;6610.438112760373;6614.470842332602;6568.146141001639;6609.834754131089;6622.4702023838945;6626.204855417284;6702.932970670328;6112.266528016667;6248.718807653667;6536.411722944958;6629.900551491732;6635.734570617218;6519.380658837403;6529.053287273414;6533.934660653333;6534.085228067979;6534.542582019213;6452.774152904626;6456.257530384066;6462;6465.903011454926;6478.643674597943;6469.644169570719;6582.8354291143105;6596.30738772422;6605.207375115017;6614.404703576702;4345.456817897762;4383.846565370197;4385.846495372647;4387.824487020611;4388.561143885586;6529.640869752019;6534.869302614016;6536.281009088902;6538.673066346569;6544.214694236532;6176.81469555914;6347.0479428086155;6356.968215158895;6363.872722545616;6364.268109167505;6195.473384762346;6229.283632382334;6246.281677607133;6248.9062664059165;6252.812415627538;6149;6151.784687535915;6160.3223645398075;6206.72069756853;6236.625802451686;6223.751049958132;6378.744850206125;6384.297727250092;6386.105945167587;6388.9041664374145;6233.189685340877;6236.282827474717;6241.251049874044;6242.750289988349;6246.094316324198 11:28:00 INFO - 2015-12-17 11:28:00,222 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.4425837201051;701.9473539484538;795.5385876191807;855.1747563601124;862.6764963138827;12573.999999999989;12758.55345062923;12769.489220431184;12797.232166070042;12943.417546210432;11384.943075284613;11403.087752979762;11592.014678752315;12425;12451.68870778231;661.1438187547114;672.6199697171107;797.2744802229972;801.410962942237;803.0203152154362;797.8045378882182;812.8983877015373;813.6013353456793;818.6316157729016;819.172635638004;852.2500199824177;860.535310932096;862.3661608717588;862.6678728689437;863.5207459859776;695.4471195399644;704.5948579566744;843.1947490146895;858.845407826591;865.208334374047;631.1542533005749;632.6583644831785;632.9905051424232;633.2559242889632;633.3349982518338;11949.581764638282;12253;12309.076819238504;12334.074944379208;12370.938145309216;11717;11894.345810980392;12159.331236781973;12351.135420520568;12524.624261272176;9162.67930622425;9180.816383672356;9351.532423378872;9399.859002114974;9509.762255943588;3553.982230088859;3586.28274345132;3589.515415418937;3594.19130695594;3633.3459977204093;44689.77655111704;44882.77558612219;45168;45204.321935171;45371.092578148586;9869.506524673738;9904.207663386911;9904.950475247722;9984.251181161442;9985.20118390527;18189.45431637053;18247;18448.26206951707;18541;18563.16465759044;6927.411170050501;6961.686724097428;7064.364207221375;7243.818904527324;7375.225601311892;3912.902177445587;4029.274730548471;4044.939325910114;4084.65280451159;4119.773412462283;2584.6639936808097;2591.287395966124;2593.975379724998;2620.9606855897177;2621.501914636213;516.8940367224785;535.9356877174686;538.9382915656151;542.4765101676901;542.6282996147652;499.6502448286214;560.2101781448504;641.5060403489288;646.6314200905533;651.2738296799035;8387.203215694499;8540.145985401534;8767.868481972775;8791;8800.95599522011;466.9066186762661;595.7051259626512;625;648.2998361769278;658.6377492379172;3859.4982652255026;3908.5309762828642;4093.795310234536;4152.211079894811;4192.161567686414;49627.50372496301;49742.751286243336;49945.50054499409;50317.496825032016;50657.493425066015;43636.345454818205;43752.343714844304;48528.75735621299;49002;49171.262431063566;44318.99999999935;44380.556194438286;45181.32228016583;45264.77367613141;45568.3164752529;8685.739427817176;8701.956490217508;8733.694320698745;8972.685955991508;9152.22206112488;33732.83133584316;34267.14332141716;34458;35139.64860351364;35185;39913;39932.60067399405;39965;44676;45158.77420612876;10513.789724205626;10575.62985295511;10582.735431614272;10644.414557199429;10795.838062428913;11900.940495297467;12009.099317551043;12084.637460876187;12431.31627760482;12635.557755478882;11144.108471322113;11427.257228280136;11564.132690048113;11792.29246245228;11800.150889453444;10665.306755060896;10821.188410869374;11029.51447785914;11067.72330691739;11675.532978680758;11200.943995279971;11384.943075284571;11480.368579727861;11542.480588373712;11789.115816313639;9339.5797189128;9801.411915285105;9821.36161149523;10017.298789084694;10059.144972677112;8769.649214031622;9114.316426267924;9255;9334.159925606727;9791.216702663913 11:28:00 INFO - 2015-12-17 11:28:00,222 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:28:00 INFO - 2015-12-17 11:28:00,222 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:28:00 INFO - 2015-12-17 11:28:00,222 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,946 11:28:00 INFO - 2015-12-17 11:28:00,222 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: __startTimestamp1450380480212__endTimestamp 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5284.20 Median:5442.70 stddev:576.27 (10.6%) stddev-sans-first:552.94 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: Values: 3139.7 3182.9 3186.2 3229.0 3249.1 5125.6 5231.6 5318.7 5406.7 5440.6 5226.7 5228.6 5278.3 5327.7 5332.6 4796.0 4797.2 4824.7 4845.0 4891.3 4514.3 4896.5 4943.2 4952.3 4988.6 4689.7 4729.9 4798.4 4907.6 4910.5 4827.1 4850.0 4858.3 4863.2 4883.8 4822.3 4838.6 4842.1 4849.3 4862.4 4968.3 5039.3 5047.1 5223.7 5227.1 5668.7 5748.2 5749.5 5756.6 5802.1 5779.6 5782.7 5784.8 5786.6 5792.9 5182.9 5286.1 5288.0 5399.0 5402.4 5766.5 5883.2 5889.4 5928.6 5937.1 5615.9 5618.2 5618.2 5621.6 5667.8 5552.4 5705.7 5712.6 5714.7 5724.6 5664.3 5723.9 5762.1 5782.5 5805.5 5692.8 5693.3 5693.4 5699.3 5716.9 4333.0 4372.9 4417.8 4425.2 4451.1 3927.5 3956.6 3971.5 3987.6 3989.4 5334.2 5350.3 5350.4 5352.8 5359.5 5697.3 5733.8 5813.5 5817.2 5821.2 5336.9 5381.1 5383.9 5387.8 5390.9 5013.3 5020.2 5024.8 5027.3 5061.0 5665.9 5706.2 5795.2 5811.9 5819.2 5650.7 5692.5 5706.1 5710.5 5724.1 5725.2 5726.9 5751.1 5764.4 5767.9 5471.7 5569.9 5582.7 5584.1 5618.4 5642.8 5647.3 5678.7 5699.5 5714.2 5510.2 5513.3 5516.4 5526.1 5533.9 5409.4 5476.2 5509.1 5517.3 5560.6 5412.6 5442.7 5519.3 5533.3 5564.9 5531.4 5532.5 5544.8 5594.7 5606.8 5313.1 5425.9 5426.7 5427.4 5435.1 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46915.96 Median:33074.17 stddev:80321.27 (242.9%) stddev-sans-first:80471.26 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: Values: 583.6 586.3 587.9 587.9 614.3 29727.9 31062.4 31064.5 37901.4 38297.8 42675.0 42863.4 42935.8 43037.8 43226.4 8427.5 8702.4 8703.1 8704.4 8708.5 7606.7 7753.7 10305.4 10496.8 10503.7 10106.2 10189.5 10246.4 10247.3 10266.7 7591.4 7753.2 9917.2 9992.3 9997.1 10270.3 10489.3 10489.8 10504.8 10518.5 38956.8 39613.9 39652.4 39678.4 39699.8 3130.9 3276.9 3411.9 3519.7 3818.8 30099.2 30603.4 30739.5 30753.2 31223.5 3910.1 4020.1 4050.9 4073.2 4146.3 260029.0 260736.0 261270.0 261274.0 262084.0 58757.4 59124.7 59690.7 59693.0 59696.4 60669.4 62005.4 63378.4 63640.4 63906.4 14217.0 16034.7 16505.2 16520.6 16535.3 11458.5 11476.9 11605.5 11623.7 11627.9 19361.6 19368.6 19399.7 19410.3 19412.8 7493.9 7741.1 7763.8 7828.6 7879.0 801.4 909.8 934.8 939.0 1058.7 27388.7 27463.5 27644.6 27871.0 27874.6 1000.1 1016.8 1026.7 1090.5 1092.4 14222.4 16290.8 16674.2 16674.6 16721.2 385977.0 390333.0 390602.0 391340.0 391668.0 52286.0 52600.5 52767.5 52814.0 52932.7 1278.9 1285.0 1301.5 1306.8 1309.3 28687.1 29015.6 29225.0 29715.9 29737.3 40895.2 41691.2 44911.0 45460.0 45783.8 244768.0 244793.0 247023.0 247412.0 247757.0 30481.7 30731.7 30732.5 30859.7 31181.8 33902.3 41307.4 41666.4 41807.8 42632.4 32782.7 32879.0 33269.3 33702.5 33868.5 40163.6 41248.0 41447.8 41659.8 42561.4 35612.3 35718.6 35822.8 38245.6 38845.0 30319.7 32149.2 32624.2 32645.5 32725.2 24231.6 24709.1 24731.4 25170.4 25220.0 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,223 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29407.92 Median:3860.18 stddev:92175.59 (2387.9%) stddev-sans-first:92408.34 11:28:00 INFO - 2015-12-17 11:28:00,224 DEBUG : BROWSER_OUTPUT: Values: 349.1 350.9 351.4 351.6 351.7 13690.9 14014.2 16138.7 16427.5 17391.3 15784.1 15906.8 16956.6 17012.7 17017.7 4280.0 4451.7 4453.0 4453.1 4459.3 3771.6 3840.4 3880.0 4431.2 5933.6 5913.8 5942.2 5945.6 5949.4 5957.3 5787.3 5892.1 5923.8 5924.0 5931.8 5215.0 5220.9 5228.7 5229.5 5230.5 18101.7 18424.8 18962.7 20241.0 20251.2 1649.4 1830.9 1840.7 2019.5 2039.7 9008.1 9176.0 9430.4 9515.9 11702.7 1497.4 1657.7 1673.0 1720.5 1849.4 59483.0 62302.7 63356.7 63667.4 64242.4 9953.6 9960.4 10007.1 10026.3 10088.6 13280.0 13297.0 13329.5 13353.7 13364.3 7485.4 7487.2 7504.8 7543.8 7639.7 7253.6 7298.1 7313.0 7369.4 7388.7 4235.7 4311.7 4350.5 4380.9 4434.4 1713.1 1735.1 1739.3 1757.6 1765.2 801.5 845.9 905.3 922.2 973.7 15630.4 16200.4 16852.8 16930.7 17210.0 814.0 933.4 959.9 962.0 978.9 8664.4 9096.8 9097.5 9115.0 9223.4 558038.0 559787.0 560244.2 567854.0 574404.0 77740.6 78135.0 79716.0 80432.0 83552.0 1125.8 1127.9 1189.6 1190.4 1200.2 14425.0 14523.8 14638.9 14740.1 14964.0 31974.2 32589.5 32653.3 32817.5 32966.2 46055.1 47385.0 47902.5 48585.3 50664.7 9383.7 9430.8 9590.5 9693.7 9825.6 16510.9 16643.8 16944.6 17451.7 17555.7 14258.1 14316.4 14374.6 14590.4 14938.4 13899.6 13955.0 14022.6 14568.5 14742.2 11861.8 14609.3 14684.0 14800.1 15248.2 7824.6 9211.4 9240.3 9371.6 9375.2 13982.0 14500.6 14511.3 14673.8 14741.3 11:28:00 INFO - 2015-12-17 11:28:00,224 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,224 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5119.03 Median:6213.86 stddev:2631.65 (42.4%) stddev-sans-first:2623.57 11:28:00 INFO - 2015-12-17 11:28:00,225 DEBUG : BROWSER_OUTPUT: Values: 1323.9 1470.0 1529.9 1645.8 1777.6 6548.3 7100.4 7189.4 7205.5 7222.7 7117.1 7302.3 7314.5 7336.4 7359.9 1837.3 1873.4 1874.7 2090.8 2131.5 2091.1 2121.2 2133.6 2136.5 2139.1 2035.0 2035.5 2047.0 2047.6 2051.0 2047.7 2064.1 2079.1 2079.3 2080.0 2040.1 2059.0 2065.3 2066.8 2067.5 7175.4 7211.7 7212.4 7255.2 7280.0 4346.2 4425.7 4427.6 4428.8 4467.9 2915.7 3000.7 3021.4 3027.1 3037.8 960.4 966.2 971.7 995.4 1000.9 10059.8 10064.1 10071.6 10071.9 10080.6 4023.5 4032.4 4085.1 4086.1 4088.6 8576.1 8635.7 8638.8 8649.4 8690.9 4458.7 4481.6 4491.1 4493.6 4515.3 4092.9 4128.6 4133.7 4147.1 4150.3 3125.4 3136.3 3174.0 3426.1 3437.7 1065.7 1066.5 1068.5 1071.4 1073.7 1025.9 1030.2 1074.1 1165.9 1318.3 6929.1 6943.4 6964.4 7013.7 7037.9 1089.8 1105.4 1114.2 1121.9 1136.9 5413.6 5523.1 5532.5 5543.1 5544.0 8160.1 8338.6 8356.6 8455.2 8476.3 8300.0 8385.5 8399.6 8403.9 8406.3 6852.3 6876.9 6965.9 7054.3 7075.9 6887.0 6897.5 6937.8 6955.0 6962.1 7759.4 7844.3 7905.4 7913.4 7986.8 7901.5 8183.6 8186.3 8195.8 8218.6 6469.5 6476.2 6479.7 6536.1 6541.3 6327.5 6449.7 6878.6 7072.1 7154.9 6583.3 6651.4 6671.9 6703.9 6792.9 6436.5 6455.1 6482.5 6523.8 6550.9 6524.5 6567.6 6579.6 6582.8 6593.1 6203.3 6224.4 6227.0 6235.6 6244.8 6124.6 6145.2 6149.8 6171.3 6286.3 11:28:00 INFO - 2015-12-17 11:28:00,225 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,225 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5209.35 Median:5964.99 stddev:1585.80 (26.6%) stddev-sans-first:1547.18 11:28:00 INFO - 2015-12-17 11:28:00,225 DEBUG : BROWSER_OUTPUT: Values: 318.7 327.4 327.6 331.8 337.7 5916.4 5950.9 5957.4 5967.1 5996.6 5815.5 5854.3 5855.9 5857.0 5873.7 4513.3 4521.6 4522.8 4526.3 4528.2 4384.8 4473.4 4517.2 4526.5 4532.6 4395.5 4399.9 4402.7 4410.4 4467.1 4229.7 4405.2 4409.1 4414.0 4419.5 3772.0 3772.6 3834.0 3850.2 3887.0 5564.0 5564.2 5570.6 5571.7 5592.8 4945.4 5087.9 5179.5 5199.3 5200.9 6102.9 6121.0 6191.6 6196.9 6205.8 4262.2 4262.2 4266.1 4267.5 4273.8 6379.6 6445.9 6447.9 6448.8 6451.6 4286.0 4355.8 4365.6 4372.5 4384.3 4424.9 4428.1 4428.6 4428.9 4429.6 5163.1 5170.5 5175.4 5177.8 5194.9 6151.6 6283.6 6292.7 6307.4 6321.0 1554.8 1564.7 1570.8 1571.2 1571.7 1033.2 1050.3 1053.6 1054.1 1066.9 5969.2 5974.9 5975.1 5983.9 5995.4 6461.4 6463.5 6466.9 6475.4 6481.8 5958.5 5961.0 5963.1 5966.9 5968.3 3408.7 3494.5 3494.9 3495.9 3503.3 6599.9 6599.9 6608.6 6610.4 6614.5 6568.1 6609.8 6622.5 6626.2 6702.9 6112.3 6248.7 6536.4 6629.9 6635.7 6519.4 6529.1 6533.9 6534.1 6534.5 6452.8 6456.3 6462.0 6465.9 6478.6 6469.6 6582.8 6596.3 6605.2 6614.4 4345.5 4383.8 4385.8 4387.8 4388.6 6529.6 6534.9 6536.3 6538.7 6544.2 6176.8 6347.0 6357.0 6363.9 6364.3 6195.5 6229.3 6246.3 6248.9 6252.8 6149.0 6151.8 6160.3 6206.7 6236.6 6223.8 6378.7 6384.3 6386.1 6388.9 6233.2 6236.3 6241.3 6242.8 6246.1 11:28:00 INFO - 2015-12-17 11:28:00,226 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,226 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13089.93 Median:45234.55 stddev:14725.24 (32.6%) stddev-sans-first:14737.11 11:28:00 INFO - 2015-12-17 11:28:00,227 DEBUG : BROWSER_OUTPUT: Values: 692.4 701.9 795.5 855.2 862.7 12574.0 12758.6 12769.5 12797.2 12943.4 11384.9 11403.1 11592.0 12425.0 12451.7 661.1 672.6 797.3 801.4 803.0 797.8 812.9 813.6 818.6 819.2 852.3 860.5 862.4 862.7 863.5 695.4 704.6 843.2 858.8 865.2 631.2 632.7 633.0 633.3 633.3 11949.6 12253.0 12309.1 12334.1 12370.9 11717.0 11894.3 12159.3 12351.1 12524.6 9162.7 9180.8 9351.5 9399.9 9509.8 3554.0 3586.3 3589.5 3594.2 3633.3 44689.8 44882.8 45168.0 45204.3 45371.1 9869.5 9904.2 9905.0 9984.3 9985.2 18189.5 18247.0 18448.3 18541.0 18563.2 6927.4 6961.7 7064.4 7243.8 7375.2 3912.9 4029.3 4044.9 4084.7 4119.8 2584.7 2591.3 2594.0 2621.0 2621.5 516.9 535.9 538.9 542.5 542.6 499.7 560.2 641.5 646.6 651.3 8387.2 8540.1 8767.9 8791.0 8801.0 466.9 595.7 625.0 648.3 658.6 3859.5 3908.5 4093.8 4152.2 4192.2 49627.5 49742.8 49945.5 50317.5 50657.5 43636.3 43752.3 48528.8 49002.0 49171.3 44319.0 44380.6 45181.3 45264.8 45568.3 8685.7 8702.0 8733.7 8972.7 9152.2 33732.8 34267.1 34458.0 35139.6 35185.0 39913.0 39932.6 39965.0 44676.0 45158.8 10513.8 10575.6 10582.7 10644.4 10795.8 11900.9 12009.1 12084.6 12431.3 12635.6 11144.1 11427.3 11564.1 11792.3 11800.2 10665.3 10821.2 11029.5 11067.7 11675.5 11200.9 11384.9 11480.4 11542.5 11789.1 9339.6 9801.4 9821.4 10017.3 10059.1 8769.6 9114.3 9255.0 9334.2 9791.2 11:28:00 INFO - 2015-12-17 11:28:00,227 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:28:00 INFO - 2015-12-17 11:28:00,227 DEBUG : BROWSER_OUTPUT: 11:28:00 INFO - 2015-12-17 11:28:00,916 INFO : Browser exited with error code: 0 11:28:00 INFO - 2015-12-17 11:28:00,934 INFO : Completed test dromaeo_css (00:18:34) 11:28:00 INFO - 2015-12-17 11:28:00,934 INFO : Starting test kraken 11:28:00 INFO - 2015-12-17 11:28:00,934 DEBUG : operating with platform_type : linux_ 11:28:00 INFO - 2015-12-17 11:28:00,934 INFO : Initialising browser for kraken test... 11:28:00 INFO - 2015-12-17 11:28:00,940 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph5qKY1/profile http://localhost:50887/getInfo.html 11:28:04 INFO - 2015-12-17 11:28:04,727 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:28:04 INFO - 2015-12-17 11:28:04,728 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:28:04 INFO - 2015-12-17 11:28:04,728 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:28:04 INFO - 2015-12-17 11:28:04,728 DEBUG : BROWSER_OUTPUT: __metrics 11:28:04 INFO - 2015-12-17 11:28:04,812 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] 11:28:04 INFO - 2015-12-17 11:28:04,872 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] 11:28:05 INFO - 2015-12-17 11:28:05,912 INFO : Browser initialized. 11:28:05 INFO - 2015-12-17 11:28:05,913 INFO : Running cycle 1/1 for kraken test... 11:28:05 INFO - 2015-12-17 11:28:05,913 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph5qKY1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:28:17 INFO - 2015-12-17 11:28:17,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 149843968 11:28:17 INFO - 2015-12-17 11:28:17,688 DEBUG : BROWSER_OUTPUT: 11:28:20 INFO - 2015-12-17 11:28:20,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50887/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:20 INFO - 2015-12-17 11:28:20,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 185909248 11:28:20 INFO - 2015-12-17 11:28:20,750 DEBUG : BROWSER_OUTPUT: 11:28:23 INFO - 2015-12-17 11:28:23,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50887/tests/kraken/driver.html?testName=audio-dft) 11:28:23 INFO - 2015-12-17 11:28:23,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 177471488 11:28:23 INFO - 2015-12-17 11:28:23,927 DEBUG : BROWSER_OUTPUT: 11:28:26 INFO - 2015-12-17 11:28:26,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50887/tests/kraken/driver.html?testName=audio-fft) 11:28:27 INFO - 2015-12-17 11:28:27,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 161292288 11:28:27 INFO - 2015-12-17 11:28:27,390 DEBUG : BROWSER_OUTPUT: 11:28:29 INFO - 2015-12-17 11:28:29,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50887/tests/kraken/driver.html?testName=audio-oscillator) 11:28:29 INFO - 2015-12-17 11:28:29,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 161918976 11:28:29 INFO - 2015-12-17 11:28:29,960 DEBUG : BROWSER_OUTPUT: 11:28:32 INFO - 2015-12-17 11:28:32,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50887/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:32 INFO - 2015-12-17 11:28:32,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 165150720 11:28:32 INFO - 2015-12-17 11:28:32,754 DEBUG : BROWSER_OUTPUT: 11:28:35 INFO - 2015-12-17 11:28:35,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50887/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:36 INFO - 2015-12-17 11:28:36,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 164110336 11:28:36 INFO - 2015-12-17 11:28:36,193 DEBUG : BROWSER_OUTPUT: 11:28:39 INFO - 2015-12-17 11:28:39,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50887/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:40 INFO - 2015-12-17 11:28:40,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 165396480 11:28:40 INFO - 2015-12-17 11:28:40,126 DEBUG : BROWSER_OUTPUT: 11:28:42 INFO - 2015-12-17 11:28:42,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50887/tests/kraken/driver.html?testName=json-parse-financial) 11:28:43 INFO - 2015-12-17 11:28:43,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 166703104 11:28:43 INFO - 2015-12-17 11:28:43,417 DEBUG : BROWSER_OUTPUT: 11:28:45 INFO - 2015-12-17 11:28:45,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50887/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:45 INFO - 2015-12-17 11:28:45,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 175214592 11:28:45 INFO - 2015-12-17 11:28:45,572 DEBUG : BROWSER_OUTPUT: 11:28:47 INFO - 2015-12-17 11:28:47,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:47 INFO - 2015-12-17 11:28:47,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 175620096 11:28:47 INFO - 2015-12-17 11:28:47,955 DEBUG : BROWSER_OUTPUT: 11:28:49 INFO - 2015-12-17 11:28:49,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:50 INFO - 2015-12-17 11:28:50,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 187527168 11:28:50 INFO - 2015-12-17 11:28:50,568 DEBUG : BROWSER_OUTPUT: 11:28:53 INFO - 2015-12-17 11:28:53,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:54 INFO - 2015-12-17 11:28:54,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 188350464 11:28:54 INFO - 2015-12-17 11:28:54,201 DEBUG : BROWSER_OUTPUT: 11:28:56 INFO - 2015-12-17 11:28:56,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:57 INFO - 2015-12-17 11:28:57,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 186171392 11:28:57 INFO - 2015-12-17 11:28:57,337 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50887/tests/kraken/driver.html?testName=ai-astar) 11:28:59 INFO - 2015-12-17 11:28:59,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 242409472 11:28:59 INFO - 2015-12-17 11:28:59,287 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,291 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:28:59 INFO - 2015-12-17 11:28:59,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:28:59 INFO - 2015-12-17 11:28:59,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:28:59 INFO - 2015-12-17 11:28:59,292 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:28:59 INFO - 2015-12-17 11:28:59,292 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;105;112;112;112;100;111;111;119 11:28:59 INFO - 2015-12-17 11:28:59,292 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;124;151;163;122;151;146;129;164;124 11:28:59 INFO - 2015-12-17 11:28:59,292 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;159;159;160;159;159;164;160;160 11:28:59 INFO - 2015-12-17 11:28:59,292 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;82;89;71;77;71;115;93;71 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;135;94;94;94;140;94;93;137 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;108;109;109;109;110;109;109 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;145;146;145;146;146;146 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;95;96;95;96 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;56;59;58;58;57;58;66;55;59 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;66;67;67;66;68;67;67;67 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;83;84;83;84;86;85;85;84 11:28:59 INFO - 2015-12-17 11:28:59,293 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;119;115;111;119;117;116;114;116;121 11:28:59 INFO - 2015-12-17 11:28:59,294 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;162;153;148;153;139;162;143;150;138 11:28:59 INFO - 2015-12-17 11:28:59,294 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;68;68;67;65;69;65;65;70 11:28:59 INFO - 2015-12-17 11:28:59,294 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:28:59 INFO - 2015-12-17 11:28:59,294 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:28:59 INFO - 2015-12-17 11:28:59,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 11:28:59 INFO - 2015-12-17 11:28:59,294 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:28:59 INFO - 2015-12-17 11:28:59,294 DEBUG : BROWSER_OUTPUT: __startTimestamp1450380539289__endTimestamp 11:28:59 INFO - 2015-12-17 11:28:59,295 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,296 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:28:59 INFO - 2015-12-17 11:28:59,296 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:28:59 INFO - 2015-12-17 11:28:59,296 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,296 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:4.95 (4.4%) stddev-sans-first:5.24 11:28:59 INFO - 2015-12-17 11:28:59,296 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 105.0 112.0 112.0 112.0 100.0 111.0 111.0 119.0 11:28:59 INFO - 2015-12-17 11:28:59,296 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,296 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:151.00 stddev:16.97 (11.2%) stddev-sans-first:17.02 11:28:59 INFO - 2015-12-17 11:28:59,297 DEBUG : BROWSER_OUTPUT: Values: 159.0 124.0 151.0 163.0 122.0 151.0 146.0 129.0 164.0 124.0 11:28:59 INFO - 2015-12-17 11:28:59,297 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.52 (1.0%) stddev-sans-first:1.62 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 159.0 159.0 160.0 159.0 159.0 164.0 160.0 160.0 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:14.31 (19.1%) stddev-sans-first:14.69 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 82.0 89.0 71.0 77.0 71.0 115.0 93.0 71.0 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.00 stddev:21.11 (22.5%) stddev-sans-first:21.79 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 135.0 94.0 94.0 94.0 140.0 94.0 93.0 137.0 11:28:59 INFO - 2015-12-17 11:28:59,298 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,299 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 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 108.0 109.0 109.0 109.0 110.0 109.0 109.0 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.50 stddev:2.99 (5.1%) stddev-sans-first:3.13 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: Values: 60.0 56.0 59.0 58.0 58.0 57.0 58.0 66.0 55.0 59.0 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 11:28:59 INFO - 2015-12-17 11:28:59,299 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 67.0 67.0 66.0 68.0 67.0 67.0 67.0 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.05 (1.3%) stddev-sans-first:1.05 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 83.0 84.0 83.0 84.0 86.0 85.0 85.0 84.0 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:118.00 stddev:3.18 (2.7%) stddev-sans-first:3.00 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: Values: 121.0 119.0 115.0 111.0 119.0 117.0 116.0 114.0 116.0 121.0 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:151.50 stddev:8.88 (5.9%) stddev-sans-first:8.83 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: Values: 140.0 162.0 153.0 148.0 153.0 139.0 162.0 143.0 150.0 138.0 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.73 (2.6%) stddev-sans-first:1.83 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 67.0 65.0 69.0 65.0 65.0 70.0 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:28:59 INFO - 2015-12-17 11:28:59,300 DEBUG : BROWSER_OUTPUT: 11:29:00 INFO - 2015-12-17 11:29:00,072 INFO : Browser exited with error code: 0 11:29:00 INFO - 2015-12-17 11:29:00,123 INFO : Completed test kraken (00:00:59) 11:29:00 INFO - 2015-12-17 11:29:00,123 INFO : Starting test v8_7 11:29:00 INFO - 2015-12-17 11:29:00,123 DEBUG : operating with platform_type : linux_ 11:29:00 INFO - 2015-12-17 11:29:00,123 INFO : Initialising browser for v8_7 test... 11:29:00 INFO - 2015-12-17 11:29:00,129 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprxwYLz/profile http://localhost:50887/getInfo.html 11:29:04 INFO - 2015-12-17 11:29:04,111 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:29:04 INFO - 2015-12-17 11:29:04,111 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:29:04 INFO - 2015-12-17 11:29:04,111 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:29:04 INFO - 2015-12-17 11:29:04,111 DEBUG : BROWSER_OUTPUT: __metrics 11:29:04 INFO - 2015-12-17 11:29:04,208 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] 11:29:04 INFO - 2015-12-17 11:29:04,284 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] 11:29:05 INFO - 2015-12-17 11:29:04,999 INFO : Browser initialized. 11:29:05 INFO - 2015-12-17 11:29:05,000 INFO : Running cycle 1/1 for v8_7 test... 11:29:05 INFO - 2015-12-17 11:29:05,000 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprxwYLz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:29:16 INFO - 2015-12-17 11:29:16,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 149520384 11:29:16 INFO - 2015-12-17 11:29:16,783 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50887/tests/v8_7/run.html (next: http://localhost:50887/tests/v8_7/run.html) 11:29:38 INFO - 2015-12-17 11:29:38,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 573693952 11:29:38 INFO - 2015-12-17 11:29:38,415 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,417 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:29:38 INFO - 2015-12-17 11:29:38,417 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:29:38 INFO - 2015-12-17 11:29:38,417 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:29:38 INFO - 2015-12-17 11:29:38,417 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:29:38 INFO - 2015-12-17 11:29:38,417 DEBUG : BROWSER_OUTPUT: |0;Richards;166.66666666666666 11:29:38 INFO - 2015-12-17 11:29:38,417 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.00526414739613 11:29:38 INFO - 2015-12-17 11:29:38,417 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1955.078125 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: |6;Boyer;12168.674698795181 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: |7;RegExp;25794.871794871793 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: |8;Splay;616.2361623616237 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:29:38 INFO - 2015-12-17 11:29:38,418 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: __startTimestamp1450380578416__endTimestamp 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.67 Median:166.67 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: Values: 166.7 11:29:38 INFO - 2015-12-17 11:29:38,419 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,420 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.01 Median:188.01 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,420 DEBUG : BROWSER_OUTPUT: Values: 188.0 11:29:38 INFO - 2015-12-17 11:29:38,420 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,420 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,420 DEBUG : BROWSER_OUTPUT: Values: 279.3 11:29:38 INFO - 2015-12-17 11:29:38,421 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,421 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,421 DEBUG : BROWSER_OUTPUT: Values: 5186.5 11:29:38 INFO - 2015-12-17 11:29:38,421 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,422 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1955.08 Median:1955.08 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,423 DEBUG : BROWSER_OUTPUT: Values: 1955.1 11:29:38 INFO - 2015-12-17 11:29:38,423 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,423 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,423 DEBUG : BROWSER_OUTPUT: Values: 781.9 11:29:38 INFO - 2015-12-17 11:29:38,423 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,423 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,423 DEBUG : BROWSER_OUTPUT: Values: 12168.7 11:29:38 INFO - 2015-12-17 11:29:38,424 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,424 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,424 DEBUG : BROWSER_OUTPUT: Values: 25794.9 11:29:38 INFO - 2015-12-17 11:29:38,424 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,424 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.24 Median:616.24 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,424 DEBUG : BROWSER_OUTPUT: Values: 616.2 11:29:38 INFO - 2015-12-17 11:29:38,424 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-12-17 11:29:38,425 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:29:38 INFO - 2015-12-17 11:29:38,425 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:29:38 INFO - 2015-12-17 11:29:38,425 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:29:38 INFO - 2015-12-17 11:29:38,425 DEBUG : BROWSER_OUTPUT: 11:29:39 INFO - 2015-12-17 11:29:39,251 INFO : Browser exited with error code: 0 11:29:39 INFO - 2015-12-17 11:29:39,268 INFO : Completed test v8_7 (00:00:39) 11:29:39 INFO - 2015-12-17 11:29:39,455 INFO : Completed test suite (00:20:12) 11:29:39 INFO - 2015-12-17 11:29:39,455 DEBUG : Working with test: dromaeo_css 11:29:39 INFO - 2015-12-17 11:29:39,455 DEBUG : Generating results file: dromaeo_css 11:29:39 INFO - 2015-12-17 11:29:39,457 DEBUG : Working with test: kraken 11:29:39 INFO - 2015-12-17 11:29:39,457 DEBUG : Generating results file: kraken 11:29:39 INFO - 2015-12-17 11:29:39,457 INFO : javascript benchmark 11:29:39 INFO - 2015-12-17 11:29:39,457 DEBUG : Working with test: v8_7 11:29:39 INFO - 2015-12-17 11:29:39,457 DEBUG : Generating results file: v8_7 11:29:39 INFO - 2015-12-17 11:29:39,458 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:39 INFO - 2015-12-17 11:29:39,518 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:29:39 INFO - 2015-12-17 11:29:39,518 DEBUG : process_Request line: dromaeo_css 6834.52 graph.html#tests=[[72,64,35]] 11:29:39 INFO - 2015-12-17 11:29:39,518 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:39 INFO - 2015-12-17 11:29:39,552 DEBUG : process_Request line: kraken 1494.40 graph.html#tests=[[232,64,35]] 11:29:39 INFO - 2015-12-17 11:29:39,553 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:29:39 INFO - 2015-12-17 11:29:39,584 DEBUG : process_Request line: v8_7 19870.47 graph.html#tests=[[230,64,35]] 11:29:39 INFO - 2015-12-17 11:29:39,585 INFO : javascript benchmark 11:29:39 INFO - 2015-12-17 11:29:39,589 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3139.7174254317106, 3182.9204269893235, 3186.187522181843, 3228.999010306805, 3249.1227368610466, 5125.589952803776, 5231.607629427789, 5318.654287471317, 5406.729663516828, 5440.6191566590305, 5226.660267082637, 5228.633995620308, 5278.26104345391, 5327.653702509344, 5332.600054995872, 4795.976020119903, 4797.184478638623, 4824.734639594821, 4845.0, 4891.339669144673, 4514.345419914111, 4896.46138924718, 4943.233798761198, 4952.281919121725, 4988.600911927056, 4689.671722979393, 4729.929051064237, 4798.448178459487, 4907.582855457291, 4910.484399138093, 4827.106985207713, 4850.0, 4858.29554714568, 4863.197572400585, 4883.755812209375, 4822.324874517571, 4838.637102217348, 4842.104210720992, 4849.321095046696, 4862.367892173995, 4968.30443737877, 5039.3196918415915, 5047.116754567973, 5223.686578805284, 5227.085260079509, 5668.68822214778, 5748.223989761371, 5749.453801888814, 5756.625819321731, 5802.12968054791, 5779.624324418899, 5782.681952492611, 5784.797532086399, 5786.594938354317, 5792.855178620526, 5182.922256166161, 5286.07493688603, 5288.021715982517, 5398.973005134989, 5402.405735369106, 5766.481016708432, 5883.205767221456, 5889.352171261158, 5928.644281343133, 5937.079752638261, 5615.8596035098635, 5618.157276408571, 5618.2415373924, 5621.634593751393, 5667.829965101054, 5552.444755524496, 5705.74324155414, 5712.6001179917, 5714.685692286881, 5724.627899186539, 5664.2636457261115, 5723.942760572424, 5762.078067509178, 5782.45066718661, 5805.506531944748, 5692.7722891083895, 5693.28833895763, 5693.4021927696995, 5699.344575373885, 5716.9142462862255, 4333.046729719456, 4372.8906777330185, 4417.757023363682, 4425.203463376559, 4451.109778044404, 3927.4697915781576, 3956.643902048772, 3971.5234171899556, 3987.6211759882763, 3989.4215338776294, 5334.1732031535175, 5350.27771250884, 5350.384705758887, 5352.759125839347, 5359.517643412034, 5697.316322041382, 5733.827985160368, 5813.5349172066135, 5817.214676018768, 5821.214136091573, 5336.91994620081, 5381.112116500812, 5383.946160538345, 5387.757550910218, 5390.9191362129595, 5013.298138260647, 5020.196768517019, 5024.824131155392, 5027.296178535008, 5061.038402703474, 5665.943340566541, 5706.172604972338, 5795.246617939725, 5811.912821307684, 5819.214406055213, 5650.717464126859, 5692.48767610917, 5706.087026075808, 5710.486056254957, 5724.084146536534, 5725.198472213977, 5726.914096288476, 5751.079827227623, 5764.394738552392, 5767.913481297868, 5471.671699698031, 5569.944300556943, 5582.720863956867, 5584.078627026495, 5618.353889302783, 5642.802501912413, 5647.322321321468, 5678.716064196691, 5699.51554117888, 5714.171445140514, 5510.173473978935, 5513.3108361454815, 5516.420775818481, 5526.088195447706, 5533.916991245215, 5409.404965453876, 5476.17857321405, 5509.090999985118, 5517.282753242213, 5560.6107572471155, 5412.621116521806, 5442.700651464207, 5519.2824932758485, 5533.253010843485, 5564.888702226014, 5531.419200984, 5532.5020748132865, 5544.833654990357, 5594.720263986866, 5606.831795046155, 5313.149896016619, 5425.864353391197, 5426.67439953604, 5427.4301198373605, 5435.103207970798], "unit": "score", "name": "dojo.html", "value": 5247.63684705711}, {"lowerIsBetter": false, "replicates": [583.6439771739235, 586.311084475741, 587.8794847056354, 587.9323877754058, 614.2536817766415, 29727.851360743192, 31062.37875242494, 31064.53403198951, 37901.43147852785, 38297.808510957475, 42675.0, 42863.35704964428, 42935.78532107343, 43037.78481107598, 43226.351604725955, 8427.452215605981, 8702.390832641686, 8703.129687031309, 8704.389687907757, 8708.521031343274, 7606.733764318223, 7753.651085701157, 10305.38167709936, 10496.845347011822, 10503.684889453329, 10106.191504679644, 10189.490525473733, 10246.436445995467, 10247.333923294998, 10266.691999240034, 7591.354734847489, 7753.18591547885, 9917.206623470141, 9992.250581206403, 9997.100260976475, 10270.281080324381, 10489.318194317346, 10489.842652360221, 10504.842427363596, 10518.526666300035, 38956.80521597374, 39613.850199474175, 39652.40521392181, 39678.404823927376, 39699.8015009926, 3130.8591113399953, 3276.918077048069, 3411.9147021324666, 3519.7008254298416, 3818.770873747584, 30099.247518811986, 30603.387932241232, 30739.538906916416, 30753.231169220726, 31223.531647025313, 3910.1006768443135, 4020.1155745736182, 4050.858219962287, 4073.226087043482, 4146.274401979672, 260029.0, 260736.0, 261270.0, 261274.0, 262084.0, 58757.41242587605, 59124.70437647784, 59690.701546492855, 59693.0, 59696.40303596995, 60669.39330606726, 62005.37994620086, 63378.36621633724, 63640.36359636437, 63906.36093639097, 14217.004809663431, 16034.679306413806, 16505.17474126289, 16520.586985325463, 16535.338586456408, 11458.484368203452, 11476.942615286871, 11605.477753501113, 11623.6512904613, 11627.88372116268, 19361.612767744566, 19368.612627747367, 19399.709004364664, 19410.320638777575, 19412.805871941382, 7493.85012299751, 7741.148473667892, 7763.805904852424, 7828.569428681477, 7878.960605196938, 801.418971245842, 909.8225845960106, 934.756963189562, 938.9812203755887, 1058.6823952814125, 27388.726112739016, 27463.450730985267, 27644.58533122005, 27871.0, 27874.5818812718, 1000.1348833259178, 1016.8271393863062, 1026.6560702164709, 1090.4929207918356, 1092.4100985467917, 14222.431102755982, 16290.83709162917, 16674.166291685367, 16674.58218558302, 16721.16394180286, 385977.0, 390333.0, 390602.0, 391340.0, 391668.0, 52286.0, 52600.473995259556, 52767.47232527703, 52814.0, 52932.73533632307, 1278.9424475898606, 1284.9614511564669, 1301.5054279373967, 1306.8497122830995, 1309.2537253765454, 28687.139385817623, 29015.56476652894, 29225.0, 29715.851420742758, 29737.25656858596, 40895.1820963585, 41691.1661766769, 44911.0, 45460.0, 45783.77108114438, 244768.0, 244793.0, 247023.0, 247412.0, 247757.0, 30481.695183047887, 30731.692683072884, 30732.539011915287, 30859.69140308658, 31181.8440907794, 33902.32195356128, 41307.38038929358, 41666.375004375564, 41807.790961045, 42632.360514592925, 32782.672173278916, 32879.0, 33269.334613308085, 33702.49446258357, 33868.49197262093, 40163.598364017154, 41248.0, 41447.792761036, 41659.7917010413, 42561.36157957695, 35612.28775424529, 35718.64281357153, 35822.8208858954, 38245.617543824206, 38844.95015647948, 30319.696803031686, 32149.196270093435, 32624.184395390304, 32645.510317345736, 32725.181870452478, 24231.636525452486, 24709.135180268604, 24731.381715457257, 25170.37074073163, 25220.0], "unit": "score", "name": "ext.html", "value": 18647.97022275963}, {"lowerIsBetter": false, "replicates": [349.13240597116163, 350.8666706651472, 351.35526309222575, 351.6114693263945, 351.68699857127154, 13690.931545342284, 14014.159150450954, 16138.677226455478, 16427.50717478476, 17391.304347826073, 15784.131872747022, 15906.840931590681, 16956.576085597866, 17012.744808827847, 17017.74473382897, 4279.999999999992, 4451.666125040619, 4452.955470445303, 4453.064856380164, 4459.331100334944, 3771.641694039062, 3840.3855383138703, 3879.9806000970098, 4431.1802316571375, 5933.5549833762425, 5913.763449462016, 5942.197803296543, 5945.583809133363, 5949.405059494037, 5957.2851257849115, 5787.33445653751, 5892.057270836688, 5923.792667256647, 5923.970380148115, 5931.822045338604, 5215.035218484592, 5220.8694782630355, 5228.686278823283, 5229.50319719626, 5230.503102205323, 18101.7284740729, 18424.815751842445, 18962.71555926662, 20241.0, 20251.189952401885, 1649.364994477123, 1830.8993005384698, 1840.6962851129547, 2019.4547472182576, 2039.7246371739923, 9008.099190081006, 9176.0, 9430.434173949585, 9515.905670847802, 11702.707432314175, 1497.4010395841642, 1657.7109881705624, 1672.9962022786353, 1720.4924547258588, 1849.3527265456983, 59483.0, 62302.68848655773, 63356.68321658454, 63667.36332636707, 64242.3575764241, 9953.606495090693, 9960.402375857471, 10007.14939230159, 10026.298159128937, 10088.596456141819, 13280.0, 13297.0, 13329.533466328632, 13353.66615834612, 13364.331783410791, 7485.438592105614, 7487.1764105948305, 7504.849903001909, 7543.7736867894055, 7639.656215470317, 7253.56478611285, 7298.124225093023, 7313.0, 7369.447291453055, 7388.741394051182, 4235.7035007549175, 4311.698181127354, 4350.521442641307, 4380.934285985712, 4434.357018232338, 1713.092061207562, 1735.0804073840884, 1739.3042782886946, 1757.6221112460883, 1765.2321240260271, 801.4750338528273, 845.9492430454069, 905.3391024552113, 922.2207234886511, 973.7176218896583, 15630.374785008473, 16200.351985920666, 16852.831471685127, 16930.746038809426, 17210.0, 813.9674413023531, 933.3513208320288, 959.8896126945491, 962.0043255230803, 978.8678528398717, 8664.393492455594, 9096.81806363869, 9097.454152750855, 9114.954425227965, 9223.354365194506, 558038.0, 559787.0, 560244.1865697426, 567854.0, 574404.0, 77740.61129694316, 78135.0, 79716.0, 80432.0, 83552.0, 1125.763589646167, 1127.937963412004, 1189.5503041180473, 1190.4047976011993, 1200.237848965913, 14425.0, 14523.78214326807, 14638.853611463748, 14740.11559306445, 14964.0, 31974.200644984063, 32589.511157333134, 32653.346933061683, 32817.50773738348, 32966.175845604055, 46055.078898422515, 47385.0, 47902.520974789804, 48585.271220931005, 50664.74667626786, 9383.671571494964, 9430.764230894283, 9590.472524010967, 9693.660721874701, 9825.557849896915, 16510.917445412695, 16643.750343745094, 16944.57638559046, 17451.738223926906, 17555.736663949796, 14258.073225240327, 14316.427342906167, 14374.640633983816, 14590.416383344971, 14938.402463901757, 13899.583012509642, 13955.0, 14022.579322620337, 14568.49010284635, 14742.189179595225, 11861.762764744484, 14609.269536523343, 14684.0, 14800.111993280438, 15248.237588120772, 7824.64789084504, 9211.355205135576, 9240.306976976888, 9371.578278977326, 9375.249980001447, 13982.0, 14500.637484062983, 14511.346989385715, 14673.779893301822, 14741.262936853329], "unit": "score", "name": "jquery.html", "value": 8682.324248683934}, {"lowerIsBetter": false, "replicates": [1323.9205647661136, 1469.963250918727, 1529.9082055076692, 1645.7942757155356, 1777.6355847051357, 6548.27968923418, 7100.396466300364, 7189.388901943328, 7205.459590530718, 7222.711091556338, 7117.145942486909, 7302.3427891489755, 7314.451416143797, 7336.449766267538, 7359.889601655979, 1837.2834594508151, 1873.363056560769, 1874.7000479923215, 2090.822280106189, 2131.4777879419485, 2091.059023439451, 2121.2151503943564, 2133.605283022646, 2136.508603021306, 2139.1443422630996, 2034.9796502034937, 2035.4632252649303, 2046.9969714839697, 2047.6109539187507, 2050.9847625425436, 2047.6723724204205, 2064.0505367530955, 2079.105984426696, 2079.261862038977, 2079.979200208009, 2040.1125510402874, 2059.032254840223, 2065.31844491319, 2066.8243199328076, 2067.4831292176955, 7175.354218120342, 7211.675474603603, 7212.3869471094495, 7255.201927787992, 7280.0, 4346.239408103569, 4425.668074894364, 4427.623651989585, 4428.822847086113, 4467.865964021052, 2915.650121985354, 3000.744936680385, 3021.4108248891475, 3027.1372658792357, 3037.817730936151, 960.3805545423232, 966.2318456826839, 971.6696323250129, 995.382862625177, 1000.9249306302056, 10059.849102263472, 10064.144547713453, 10071.597136114546, 10071.949640251825, 10080.647177348757, 4023.4970628671417, 4032.3749818778138, 4085.0604360996545, 4086.1010577672864, 4088.6115818997146, 8576.099509551532, 8635.740927772176, 8638.784030399165, 8649.394542382099, 8690.869636955451, 4458.71018383804, 4481.596656300883, 4491.101779644085, 4493.640508759291, 4515.322701594787, 4092.897677558085, 4128.587141285848, 4133.7106402551535, 4147.108371700038, 4150.315197992298, 3125.4374212641487, 3136.2943337748825, 3173.9682603174133, 3426.0920855973186, 3437.7077948374667, 1065.722912042859, 1066.4507778494083, 1068.5458680060942, 1071.3839542263229, 1073.6564299424265, 1025.887152413234, 1030.2427715629008, 1074.08166018055, 1165.8600967883908, 1318.2815365625756, 6929.064576282238, 6943.444524438033, 6964.408025317804, 7013.684384202723, 7037.92962070383, 1089.8310761831929, 1105.4417519152776, 1114.2200459678259, 1121.9439028048564, 1136.9488373023235, 5413.621046526784, 5523.143912693539, 5532.474414930575, 5543.1408131739645, 5543.974364742536, 8160.102388737234, 8338.583070846433, 8356.582170891432, 8455.154484551496, 8476.279516241066, 8299.95850020746, 8385.496870187808, 8399.580020998925, 8403.915960840435, 8406.285465735358, 6852.314768523108, 6876.931230687729, 6965.895511567331, 7054.2945705430075, 7075.893861592081, 6886.965565172142, 6897.517173797786, 6937.791866244021, 6955.0, 6962.060121883481, 7759.379249659901, 7844.254795794391, 7905.446618736633, 7913.406494513049, 7986.800329991796, 7901.525908445512, 8183.631736571988, 8186.2632363087605, 8195.83608327842, 8218.58907054633, 6469.547131700736, 6476.222853257639, 6479.708413121327, 6536.084948107174, 6541.34586541342, 6327.462165715966, 6449.709763060768, 6878.55289406187, 7072.115985501812, 7154.928450715634, 6583.341665833378, 6651.401373876374, 6671.8999215010845, 6703.93296067033, 6792.898106528505, 6436.549441539048, 6455.096286519797, 6482.481401487964, 6523.7716679915975, 6550.901736474052, 6524.4780417565535, 6567.638779867153, 6579.572327798678, 6582.76960306387, 6593.142891424084, 6203.286622038523, 6224.439800417984, 6227.034809604518, 6235.594686345373, 6244.812655620339, 6124.601900876429, 6145.201123853871, 6149.7847575334645, 6171.259448866164, 6286.308506064238], "unit": "score", "name": "mootools.html", "value": 4215.461552481039}, {"lowerIsBetter": false, "replicates": [318.71634245521483, 327.44007746753056, 327.5545258448511, 331.7594743810739, 337.68932582024536, 5916.437938395851, 5950.940490595092, 5957.374475680045, 5967.134765459005, 5996.550258730596, 5815.47660710536, 5854.268216472941, 5855.912161317573, 5857.033589457735, 5873.676947767871, 4513.345564893097, 4521.5930566249035, 4522.819087236507, 4526.275795872661, 4528.162289976365, 4384.758838263894, 4473.373727678128, 4517.232070547998, 4526.524714904937, 4532.592066713995, 4395.472543294809, 4399.86800395987, 4402.713823601472, 4410.448693913261, 4467.084247729208, 4229.6827737919775, 4405.1850407674365, 4409.096135292273, 4413.977930110345, 4419.469663640351, 3772.0, 3772.622737726233, 3833.9839942415283, 3850.191459793447, 3887.028242939265, 5564.0, 5564.221009058735, 5570.637908535973, 5571.721413929328, 5592.832215033555, 4945.406551213841, 5087.923681144785, 5179.456157103487, 5199.272101905736, 5200.8959820803375, 6102.8779424411705, 6120.96939515304, 6191.597546159485, 6196.946519091765, 6205.844853878644, 4262.211490874167, 4262.232798096342, 4266.1254442839145, 4267.487901451846, 4273.807678654437, 6379.649119298437, 6445.93554064458, 6447.935520644827, 6448.774292899773, 6451.58064725796, 4285.957140428618, 4355.847545335898, 4365.585269399466, 4372.475302963601, 4384.342348647729, 4424.911501769947, 4428.070105277863, 4428.557144285545, 4428.933565996513, 4429.579189976947, 5163.096458119814, 5170.5346518813485, 5175.404828444702, 5177.767000484987, 5194.896102077937, 6151.569390142647, 6283.560150789401, 6292.716827742763, 6307.400796924285, 6321.0, 1554.8289688134296, 1564.6714190020223, 1570.8350623184629, 1571.2222449887379, 1571.693519763658, 1033.194108595297, 1050.2858056521638, 1053.5891002509027, 1054.1040115901421, 1066.8826429092794, 5969.194158788595, 5974.880502390015, 5975.133605627159, 5983.910241346383, 5995.400459953969, 6461.418472337512, 6463.515236357292, 6466.935330646634, 6475.384838440341, 6481.805545833632, 5958.463738263577, 5960.970195148997, 5963.135345374896, 5966.85082872923, 5968.283805943314, 3408.6761757632985, 3494.4758286257265, 3494.8602055917986, 3495.9300813983577, 3503.2818272254126, 6599.868002639921, 6599.9010014848855, 6608.603483790988, 6610.438112760373, 6614.470842332602, 6568.146141001639, 6609.834754131089, 6622.4702023838945, 6626.204855417284, 6702.932970670328, 6112.266528016667, 6248.718807653667, 6536.411722944958, 6629.900551491732, 6635.734570617218, 6519.380658837403, 6529.053287273414, 6533.934660653333, 6534.085228067979, 6534.542582019213, 6452.774152904626, 6456.257530384066, 6462.0, 6465.903011454926, 6478.643674597943, 6469.644169570719, 6582.8354291143105, 6596.30738772422, 6605.207375115017, 6614.404703576702, 4345.456817897762, 4383.846565370197, 4385.846495372647, 4387.824487020611, 4388.561143885586, 6529.640869752019, 6534.869302614016, 6536.281009088902, 6538.673066346569, 6544.214694236532, 6176.81469555914, 6347.0479428086155, 6356.968215158895, 6363.872722545616, 6364.268109167505, 6195.473384762346, 6229.283632382334, 6246.281677607133, 6248.9062664059165, 6252.812415627538, 6149.0, 6151.784687535915, 6160.3223645398075, 6206.72069756853, 6236.625802451686, 6223.751049958132, 6378.744850206125, 6384.297727250092, 6386.105945167587, 6388.9041664374145, 6233.189685340877, 6236.282827474717, 6241.251049874044, 6242.750289988349, 6246.094316324198], "unit": "score", "name": "prototype.html", "value": 4692.964869612591}, {"lowerIsBetter": false, "replicates": [692.4425837201051, 701.9473539484538, 795.5385876191807, 855.1747563601124, 862.6764963138827, 12573.999999999989, 12758.55345062923, 12769.489220431184, 12797.232166070042, 12943.417546210432, 11384.943075284613, 11403.087752979762, 11592.014678752315, 12425.0, 12451.68870778231, 661.1438187547114, 672.6199697171107, 797.2744802229972, 801.410962942237, 803.0203152154362, 797.8045378882182, 812.8983877015373, 813.6013353456793, 818.6316157729016, 819.172635638004, 852.2500199824177, 860.535310932096, 862.3661608717588, 862.6678728689437, 863.5207459859776, 695.4471195399644, 704.5948579566744, 843.1947490146895, 858.845407826591, 865.208334374047, 631.1542533005749, 632.6583644831785, 632.9905051424232, 633.2559242889632, 633.3349982518338, 11949.581764638282, 12253.0, 12309.076819238504, 12334.074944379208, 12370.938145309216, 11717.0, 11894.345810980392, 12159.331236781973, 12351.135420520568, 12524.624261272176, 9162.67930622425, 9180.816383672356, 9351.532423378872, 9399.859002114974, 9509.762255943588, 3553.982230088859, 3586.28274345132, 3589.515415418937, 3594.19130695594, 3633.3459977204093, 44689.77655111704, 44882.77558612219, 45168.0, 45204.321935171, 45371.092578148586, 9869.506524673738, 9904.207663386911, 9904.950475247722, 9984.251181161442, 9985.20118390527, 18189.45431637053, 18247.0, 18448.26206951707, 18541.0, 18563.16465759044, 6927.411170050501, 6961.686724097428, 7064.364207221375, 7243.818904527324, 7375.225601311892, 3912.902177445587, 4029.274730548471, 4044.939325910114, 4084.65280451159, 4119.773412462283, 2584.6639936808097, 2591.287395966124, 2593.975379724998, 2620.9606855897177, 2621.501914636213, 516.8940367224785, 535.9356877174686, 538.9382915656151, 542.4765101676901, 542.6282996147652, 499.6502448286214, 560.2101781448504, 641.5060403489288, 646.6314200905533, 651.2738296799035, 8387.203215694499, 8540.145985401534, 8767.868481972775, 8791.0, 8800.95599522011, 466.9066186762661, 595.7051259626512, 625.0, 648.2998361769278, 658.6377492379172, 3859.4982652255026, 3908.5309762828642, 4093.795310234536, 4152.211079894811, 4192.161567686414, 49627.50372496301, 49742.751286243336, 49945.50054499409, 50317.496825032016, 50657.493425066015, 43636.345454818205, 43752.343714844304, 48528.75735621299, 49002.0, 49171.262431063566, 44318.99999999935, 44380.556194438286, 45181.32228016583, 45264.77367613141, 45568.3164752529, 8685.739427817176, 8701.956490217508, 8733.694320698745, 8972.685955991508, 9152.22206112488, 33732.83133584316, 34267.14332141716, 34458.0, 35139.64860351364, 35185.0, 39913.0, 39932.60067399405, 39965.0, 44676.0, 45158.77420612876, 10513.789724205626, 10575.62985295511, 10582.735431614272, 10644.414557199429, 10795.838062428913, 11900.940495297467, 12009.099317551043, 12084.637460876187, 12431.31627760482, 12635.557755478882, 11144.108471322113, 11427.257228280136, 11564.132690048113, 11792.29246245228, 11800.150889453444, 10665.306755060896, 10821.188410869374, 11029.51447785914, 11067.72330691739, 11675.532978680758, 11200.943995279971, 11384.943075284571, 11480.368579727861, 11542.480588373712, 11789.115816313639, 9339.5797189128, 9801.411915285105, 9821.36161149523, 10017.298789084694, 10059.144972677112, 8769.649214031622, 9114.316426267924, 9255.0, 9334.159925606727, 9791.216702663913], "unit": "score", "name": "yui.html", "value": 6062.921369547889}], "name": "dromaeo_css", "value": 6834.51892381438}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 112.0, 112.0, 112.0, 100.0, 111.0, 111.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [159.0, 124.0, 151.0, 163.0, 122.0, 151.0, 146.0, 129.0, 164.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 159.0, 160.0, 159.0, 159.0, 164.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 82.0, 89.0, 71.0, 77.0, 71.0, 115.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 94.0, 94.0, 94.0, 140.0, 94.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 56.0, 59.0, 58.0, 58.0, 57.0, 58.0, 66.0, 55.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 84.0, 83.0, 84.0, 86.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 115.0, 111.0, 119.0, 117.0, 116.0, 114.0, 116.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [140.0, 162.0, 153.0, 148.0, 153.0, 139.0, 162.0, 143.0, 150.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 65.0, 69.0, 65.0, 65.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1494.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.66666666666666], "unit": "score", "name": "Richards", "value": 211.81200000000004}, {"lowerIsBetter": false, "replicates": [188.00526414739613], "unit": "score", "name": "DeltaBlue", "value": 351.68164199999995}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1955.078125], "unit": "score", "name": "RayTrace", "value": 378.49587212787225}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [616.2361623616237], "unit": "score", "name": "Splay", "value": 132.2398862275449}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19870.47295787509}]} 11:29:39 INFO - RETURN: dromaeo_css: 6834.52 11:29:39 INFO - RETURN: kraken: 1494.40 11:29:39 INFO - RETURN: v8_7: 19870.47 11:29:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19870.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1494.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6834.52"}}} 11:29:39 INFO - Return code: 0 11:29:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:29:39 INFO - # TBPL SUCCESS # 11:29:39 INFO - Running post-action listener: _resource_record_post_action 11:29:39 INFO - Running post-run listener: _resource_record_post_run 11:29:40 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10588160; Write bytes: 444751872; Read time: 2916; Write time: 341264 11:29:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 139960320; Read time: 192; Write time: 145108 11:29:40 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8822784; Write bytes: 304791552; Read time: 2684; Write time: 196156 11:29:40 INFO - Running post-run listener: _upload_blobber_files 11:29:40 INFO - Blob upload gear active. 11:29:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:29:40 INFO - Copying logs to upload dir... 11:29:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.887567 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 11:29:40.793059) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:29:40.796804) ========= 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=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/Jdki7IJGTY2bmN8jtVYDIA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:29:40.846899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:29:40.847180) ========= 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=801756c90a5e5cfe63934219000001c7-1450376727.25302-1828265062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:29:40.895922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 11:29:40.896202) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 11:29:40.896482) ========= ========= Total master_lag: 0.21 =========