builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1450388853.36 results: success (0) buildid: 20151217113032 builduid: 8235816314f64c75936782aacb7c7a5c revision: 6a2ad662612370d248530465d690785c20abcf0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.355471) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.355972) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.356336) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006278 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.382824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.383176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.433176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.433874) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.491228) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.491935) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.492624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.493136) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 13:47:33-- 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% 40.2M=0s 2015-12-17 13:47:34 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.199574 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.730210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.730562) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017737 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.783341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 13:47:33.783709) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a2ad662612370d248530465d690785c20abcf0b --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 6a2ad662612370d248530465d690785c20abcf0b --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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 13:47:34,228 truncating revision to first 12 chars 2015-12-17 13:47:34,229 Setting DEBUG logging. 2015-12-17 13:47:34,229 attempt 1/10 2015-12-17 13:47:34,229 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a2ad6626123?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 13:47:35,111 unpacking tar archive at: fx-team-6a2ad6626123/testing/mozharness/ program finished with exit code 0 elapsedTime=1.198267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 13:47:34.999098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.999461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:35.009684) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:35.009972) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:35.010412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 13:47:35.010730) ========= /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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:47:35 INFO - MultiFileLogger online at 20151217 13:47:35 in /builds/slave/test-pgo 13:47:35 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 13:47:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:47:35 INFO - {'append_to_log': False, 13:47:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:47:35 INFO - 'blob_upload_branch': 'Fx-Team', 13:47:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:47:35 INFO - 'branch': 'Fx-Team', 13:47:35 INFO - 'buildbot_json_path': 'buildprops.json', 13:47:35 INFO - 'config_files': ('talos/linux_config.py',), 13:47:35 INFO - 'default_actions': ('clobber', 13:47:35 INFO - 'read-buildbot-config', 13:47:35 INFO - 'download-and-extract', 13:47:35 INFO - 'populate-webroot', 13:47:35 INFO - 'create-virtualenv', 13:47:35 INFO - 'install', 13:47:35 INFO - 'run-tests'), 13:47:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:47:35 INFO - 'download_minidump_stackwalk': True, 13:47:35 INFO - 'download_symbols': 'ondemand', 13:47:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:47:35 INFO - 'tooltool.py': '/tools/tooltool.py', 13:47:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:47:35 INFO - '/tools/misc-python/virtualenv.py')}, 13:47:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:47:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:47:35 INFO - 'installer_path': 'installer.exe', 13:47:35 INFO - 'log_level': 'info', 13:47:35 INFO - 'log_name': 'talos', 13:47:35 INFO - 'log_to_console': True, 13:47:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:47:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:47:35 INFO - 'opt_config_files': (), 13:47:35 INFO - 'pip_index': False, 13:47:35 INFO - 'sps_profile': False, 13:47:35 INFO - 'sps_profile_interval': 0, 13:47:35 INFO - 'suite': 'dromaeojs', 13:47:35 INFO - 'system_bits': '64', 13:47:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:47:35 INFO - 'title': 'talos-linux64-ix-056', 13:47:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:47:35 INFO - 'use_talos_json': True, 13:47:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:47:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:47:35 INFO - 'work_dir': 'build'} 13:47:35 INFO - ##### 13:47:35 INFO - ##### Running clobber step. 13:47:35 INFO - ##### 13:47:35 INFO - Running pre-action listener: _resource_record_pre_action 13:47:35 INFO - Running main action method: clobber 13:47:35 INFO - rmtree: /builds/slave/test-pgo/build 13:47:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:47:35 INFO - Running post-action listener: _resource_record_post_action 13:47:35 INFO - ##### 13:47:35 INFO - ##### Running read-buildbot-config step. 13:47:35 INFO - ##### 13:47:35 INFO - Running pre-action listener: _resource_record_pre_action 13:47:35 INFO - Running main action method: read_buildbot_config 13:47:35 INFO - Using buildbot properties: 13:47:35 INFO - { 13:47:35 INFO - "project": "", 13:47:35 INFO - "product": "firefox", 13:47:35 INFO - "script_repo_revision": "production", 13:47:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:47:35 INFO - "repository": "", 13:47:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:47:35 INFO - "buildid": "20151217113032", 13:47:35 INFO - "pgo_build": "True", 13:47:35 INFO - "basedir": "/builds/slave/test-pgo", 13:47:35 INFO - "buildnumber": 373, 13:47:35 INFO - "slavename": "talos-linux64-ix-056", 13:47:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:47:35 INFO - "platform": "ubuntu64_hw", 13:47:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:47:35 INFO - "branch": "fx-team", 13:47:35 INFO - "repo_path": "integration/fx-team", 13:47:35 INFO - "revision": "6a2ad662612370d248530465d690785c20abcf0b", 13:47:35 INFO - "stage_platform": "linux64-pgo", 13:47:35 INFO - "builduid": "8235816314f64c75936782aacb7c7a5c", 13:47:35 INFO - "slavebuilddir": "test" 13:47:35 INFO - } 13:47:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:47:35 INFO - Running post-action listener: _resource_record_post_action 13:47:35 INFO - ##### 13:47:35 INFO - ##### Running download-and-extract step. 13:47:35 INFO - ##### 13:47:35 INFO - Running pre-action listener: _resource_record_pre_action 13:47:35 INFO - Running main action method: download_and_extract 13:47:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:47: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')]} 13:47:35 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json 13:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json 13:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:47:37 INFO - Downloaded 1302 bytes. 13:47:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:47:37 INFO - Using the following test package requirements: 13:47:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:47:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:37 INFO - u'jsshell-linux-x86_64.zip'], 13:47:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:47:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:47:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:47:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:47:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:47:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:37 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:40 INFO - Downloaded 23120102 bytes. 13:47: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 13:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47: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 13:47:41 INFO - Return code: 0 13:47:41 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 13:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:41 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:43 INFO - Downloaded 23120102 bytes. 13:47:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:47:44 INFO - Return code: 0 13:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:44 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:48 INFO - Downloaded 11132039 bytes. 13:47:49 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 13:47:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:49 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 13:47:49 INFO - Return code: 0 13:47:49 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')]} 13:47:49 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:51 INFO - Downloaded 54643098 bytes. 13:47:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:51 INFO - mkdir: /builds/slave/test-pgo/properties 13:47:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:47:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:47:51 INFO - Contents: 13:47:51 INFO - build_url:https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:51 INFO - Running post-action listener: _resource_record_post_action 13:47:51 INFO - Running post-action listener: set_extra_try_arguments 13:47:51 INFO - ##### 13:47:51 INFO - ##### Running populate-webroot step. 13:47:51 INFO - ##### 13:47:51 INFO - Running pre-action listener: _resource_record_pre_action 13:47:51 INFO - Running main action method: populate_webroot 13:47:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:47:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:47:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:47:51 INFO - '--tppagecycles', 13:47:51 INFO - '7'], 13:47:51 INFO - 'tests': ['tsvgm']}}, 13:47:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:47:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:47:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:47:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:47:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'tests': ['damp', 'tps']}, 13:47:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['damp', 'tps']}, 13:47:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:47:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:47:51 INFO - 'other': {'tests': ['a11yr', 13:47:51 INFO - 'ts_paint', 13:47:51 INFO - 'tpaint', 13:47:51 INFO - 'sessionrestore', 13:47:51 INFO - 'sessionrestore_no_auto_restore']}, 13:47:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['a11yr', 13:47:51 INFO - 'ts_paint', 13:47:51 INFO - 'tpaint', 13:47:51 INFO - 'sessionrestore', 13:47:51 INFO - 'sessionrestore_no_auto_restore']}, 13:47:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['a11yr', 13:47:51 INFO - 'ts_paint', 13:47:51 INFO - 'tpaint', 13:47:51 INFO - 'sessionrestore', 13:47:51 INFO - 'sessionrestore_no_auto_restore']}, 13:47:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['a11yr', 13:47:51 INFO - 'ts_paint', 13:47:51 INFO - 'tpaint', 13:47:51 INFO - 'sessionrestore', 13:47:51 INFO - 'sessionrestore_no_auto_restore']}, 13:47:51 INFO - 'other_l64': {'tests': ['a11yr', 13:47:51 INFO - 'ts_paint', 13:47:51 INFO - 'tpaint', 13:47:51 INFO - 'sessionrestore', 13:47:51 INFO - 'sessionrestore_no_auto_restore']}, 13:47:51 INFO - 'other_nol64': {'tests': ['a11yr', 13:47:51 INFO - 'ts_paint', 13:47:51 INFO - 'tpaint', 13:47:51 INFO - 'sessionrestore', 13:47:51 INFO - 'sessionrestore_no_auto_restore']}, 13:47:51 INFO - 'svgr': {'tests': ['tsvgx', 13:47:51 INFO - 'tsvgr_opacity', 13:47:51 INFO - 'tart', 13:47:51 INFO - 'tscrollx', 13:47:51 INFO - 'cart']}, 13:47:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['tsvgx', 13:47:51 INFO - 'tsvgr_opacity', 13:47:51 INFO - 'tart', 13:47:51 INFO - 'tscrollx', 13:47:51 INFO - 'cart']}, 13:47:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'tests': ['tp5o']}, 13:47:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'talos_options': ['--e10s'], 13:47:51 INFO - 'tests': ['tp5o']}, 13:47:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'talos_options': ['--xperf_path', 13:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:51 INFO - 'tests': ['tp5n']}, 13:47:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:51 INFO - 'talos_options': ['--e10s', 13:47:51 INFO - '--xperf_path', 13:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:51 INFO - 'tests': ['tp5n']}}, 13:47:51 INFO - 'talos.zip': {'path': '', 13:47:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:47:51 INFO - Running post-action listener: _resource_record_post_action 13:47:51 INFO - ##### 13:47:51 INFO - ##### Running create-virtualenv step. 13:47:51 INFO - ##### 13:47:51 INFO - Running pre-action listener: _resource_record_pre_action 13:47:51 INFO - Running main action method: create_virtualenv 13:47:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:47:51 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 13:47:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:47:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:47:51 INFO - Using real prefix '/usr' 13:47:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:47:52 INFO - Installing distribute.............................................................................................................................................................................................done. 13:47:54 INFO - Installing pip.................done. 13:47:54 INFO - Return code: 0 13:47:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:47:54 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')]} 13:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:54 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')]} 13:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:54 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:47:54 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 13:47:54 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 13:47:54 INFO - Using env: {'DISPLAY': ':0', 13:47:54 INFO - 'HOME': '/home/cltbld', 13:47:54 INFO - 'LANG': 'en_US.UTF-8', 13:47:54 INFO - 'LANGUAGE': 'en_US:en', 13:47:54 INFO - 'LOGNAME': 'cltbld', 13:47:54 INFO - 'MAIL': '/var/mail/cltbld', 13:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:54 INFO - 'MOZ_NO_REMOTE': '1', 13:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:54 INFO - 'NO_EM_RESTART': '1', 13:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:54 INFO - 'SHELL': '/bin/bash', 13:47:54 INFO - 'SHLVL': '1', 13:47:54 INFO - 'TERM': 'linux', 13:47:54 INFO - 'TMOUT': '86400', 13:47:54 INFO - 'USER': 'cltbld', 13:47:54 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:54 INFO - '_': '/tools/buildbot/bin/python'} 13:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:54 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 13:47:54 INFO - Cleaning up... 13:47:54 INFO - Return code: 0 13:47:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:47:54 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')]} 13:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:54 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')]} 13:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:54 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:47:54 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 13:47:54 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 13:47:54 INFO - Using env: {'DISPLAY': ':0', 13:47:54 INFO - 'HOME': '/home/cltbld', 13:47:54 INFO - 'LANG': 'en_US.UTF-8', 13:47:54 INFO - 'LANGUAGE': 'en_US:en', 13:47:54 INFO - 'LOGNAME': 'cltbld', 13:47:54 INFO - 'MAIL': '/var/mail/cltbld', 13:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:54 INFO - 'MOZ_NO_REMOTE': '1', 13:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:54 INFO - 'NO_EM_RESTART': '1', 13:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:54 INFO - 'SHELL': '/bin/bash', 13:47:54 INFO - 'SHLVL': '1', 13:47:54 INFO - 'TERM': 'linux', 13:47:54 INFO - 'TMOUT': '86400', 13:47:54 INFO - 'USER': 'cltbld', 13:47:54 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:54 INFO - '_': '/tools/buildbot/bin/python'} 13:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:54 INFO - Downloading/unpacking psutil>=0.7.1 13:47:54 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 13:47:54 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 13:47:54 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 13:47:54 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 13:47:54 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 13:47:54 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 13:47:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:56 INFO - Installing collected packages: psutil 13:47:56 INFO - Running setup.py install for psutil 13:47:56 INFO - building 'psutil._psutil_linux' extension 13:47:56 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 13:47:56 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 13:47:56 INFO - building 'psutil._psutil_posix' extension 13:47:56 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 13:47:56 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 13:47:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:57 INFO - Successfully installed psutil 13:47:57 INFO - Cleaning up... 13:47:57 INFO - Return code: 0 13:47:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:57 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:47:57 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 13:47:57 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 13:47:57 INFO - Using env: {'DISPLAY': ':0', 13:47:57 INFO - 'HOME': '/home/cltbld', 13:47:57 INFO - 'LANG': 'en_US.UTF-8', 13:47:57 INFO - 'LANGUAGE': 'en_US:en', 13:47:57 INFO - 'LOGNAME': 'cltbld', 13:47:57 INFO - 'MAIL': '/var/mail/cltbld', 13:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:57 INFO - 'MOZ_NO_REMOTE': '1', 13:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:57 INFO - 'NO_EM_RESTART': '1', 13:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:57 INFO - 'SHELL': '/bin/bash', 13:47:57 INFO - 'SHLVL': '1', 13:47:57 INFO - 'TERM': 'linux', 13:47:57 INFO - 'TMOUT': '86400', 13:47:57 INFO - 'USER': 'cltbld', 13:47:57 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:57 INFO - '_': '/tools/buildbot/bin/python'} 13:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:47:57 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 13:47:57 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 13:47:57 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 13:47:57 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 13:47:57 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 13:47:57 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 13:47:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:47:59 INFO - Installing collected packages: mozsystemmonitor 13:47:59 INFO - Running setup.py install for mozsystemmonitor 13:47:59 INFO - Successfully installed mozsystemmonitor 13:47:59 INFO - Cleaning up... 13:47:59 INFO - Return code: 0 13:47:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:59 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:47:59 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 13:47:59 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 13:47:59 INFO - Using env: {'DISPLAY': ':0', 13:47:59 INFO - 'HOME': '/home/cltbld', 13:47:59 INFO - 'LANG': 'en_US.UTF-8', 13:47:59 INFO - 'LANGUAGE': 'en_US:en', 13:47:59 INFO - 'LOGNAME': 'cltbld', 13:47:59 INFO - 'MAIL': '/var/mail/cltbld', 13:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:59 INFO - 'MOZ_NO_REMOTE': '1', 13:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:59 INFO - 'NO_EM_RESTART': '1', 13:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:47:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:47:59 INFO - 'SHELL': '/bin/bash', 13:47:59 INFO - 'SHLVL': '1', 13:47:59 INFO - 'TERM': 'linux', 13:47:59 INFO - 'TMOUT': '86400', 13:47:59 INFO - 'USER': 'cltbld', 13:47:59 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:59 INFO - '_': '/tools/buildbot/bin/python'} 13:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:59 INFO - Downloading/unpacking blobuploader==1.2.4 13:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:01 INFO - Downloading blobuploader-1.2.4.tar.gz 13:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:48:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:48:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:01 INFO - Downloading docopt-0.6.1.tar.gz 13:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:48:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:48:01 INFO - Running setup.py install for blobuploader 13:48:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:48:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:48:01 INFO - Running setup.py install for requests 13:48:02 INFO - Running setup.py install for docopt 13:48:02 INFO - Successfully installed blobuploader requests docopt 13:48:02 INFO - Cleaning up... 13:48:02 INFO - Return code: 0 13:48:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:48:02 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')]} 13:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:02 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')]} 13:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:02 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:48:02 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 13:48:02 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 13:48:02 INFO - Using env: {'DISPLAY': ':0', 13:48:02 INFO - 'HOME': '/home/cltbld', 13:48:02 INFO - 'LANG': 'en_US.UTF-8', 13:48:02 INFO - 'LANGUAGE': 'en_US:en', 13:48:02 INFO - 'LOGNAME': 'cltbld', 13:48:02 INFO - 'MAIL': '/var/mail/cltbld', 13:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:02 INFO - 'MOZ_NO_REMOTE': '1', 13:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:02 INFO - 'NO_EM_RESTART': '1', 13:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:02 INFO - 'SHELL': '/bin/bash', 13:48:02 INFO - 'SHLVL': '1', 13:48:02 INFO - 'TERM': 'linux', 13:48:02 INFO - 'TMOUT': '86400', 13:48:02 INFO - 'USER': 'cltbld', 13:48:02 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:02 INFO - '_': '/tools/buildbot/bin/python'} 13:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48:02 INFO - Running setup.py (path:/tmp/pip-G3esC0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:02 INFO - Running setup.py (path:/tmp/pip-w9knba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:02 INFO - Running setup.py (path:/tmp/pip-VjU96n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:02 INFO - Running setup.py (path:/tmp/pip-RVVIgU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:03 INFO - Running setup.py (path:/tmp/pip-BL_ygh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48:03 INFO - Running setup.py (path:/tmp/pip-YTad0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48:03 INFO - Running setup.py (path:/tmp/pip-nGjmuG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48:03 INFO - Running setup.py (path:/tmp/pip-_EvD3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48:03 INFO - Running setup.py (path:/tmp/pip-cVmQha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48:03 INFO - Running setup.py (path:/tmp/pip-LMLpAc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48:03 INFO - Running setup.py (path:/tmp/pip-HAX0Vt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48:03 INFO - Running setup.py (path:/tmp/pip-2UlZju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48:03 INFO - Running setup.py (path:/tmp/pip-fqRZBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48:03 INFO - Running setup.py (path:/tmp/pip-ViGYmX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48:03 INFO - Running setup.py (path:/tmp/pip-9aSHY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:03 INFO - Running setup.py (path:/tmp/pip-odLyoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:03 INFO - Running setup.py (path:/tmp/pip-2zRxQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:48:03 INFO - Running setup.py install for manifestparser 13:48:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Running setup.py install for mozcrash 13:48:04 INFO - Running setup.py install for mozdebug 13:48:04 INFO - Running setup.py install for mozdevice 13:48:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Running setup.py install for mozfile 13:48:04 INFO - Running setup.py install for mozhttpd 13:48:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Running setup.py install for mozinfo 13:48:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Running setup.py install for mozInstall 13:48:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Running setup.py install for mozleak 13:48:04 INFO - Running setup.py install for mozlog 13:48:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:48:04 INFO - Running setup.py install for moznetwork 13:48:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:48:05 INFO - Running setup.py install for mozprocess 13:48:05 INFO - Running setup.py install for mozprofile 13:48:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:48:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:48:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:48:05 INFO - Running setup.py install for mozrunner 13:48:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:48:05 INFO - Running setup.py install for mozscreenshot 13:48:05 INFO - Running setup.py install for moztest 13:48:05 INFO - Running setup.py install for mozversion 13:48:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:48:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:48:05 INFO - Cleaning up... 13:48:05 INFO - Return code: 0 13:48:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:05 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:48:05 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 13:48:05 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 13:48:05 INFO - Using env: {'DISPLAY': ':0', 13:48:05 INFO - 'HOME': '/home/cltbld', 13:48:05 INFO - 'LANG': 'en_US.UTF-8', 13:48:05 INFO - 'LANGUAGE': 'en_US:en', 13:48:05 INFO - 'LOGNAME': 'cltbld', 13:48:05 INFO - 'MAIL': '/var/mail/cltbld', 13:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:05 INFO - 'MOZ_NO_REMOTE': '1', 13:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:05 INFO - 'NO_EM_RESTART': '1', 13:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:05 INFO - 'SHELL': '/bin/bash', 13:48:05 INFO - 'SHLVL': '1', 13:48:05 INFO - 'TERM': 'linux', 13:48:05 INFO - 'TMOUT': '86400', 13:48:05 INFO - 'USER': 'cltbld', 13:48:05 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:05 INFO - '_': '/tools/buildbot/bin/python'} 13:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48:05 INFO - Running setup.py (path:/tmp/pip-QDtUda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:06 INFO - Running setup.py (path:/tmp/pip-Gf3HJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:06 INFO - Running setup.py (path:/tmp/pip-M7Dydh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:06 INFO - Running setup.py (path:/tmp/pip-_SoKHa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:06 INFO - Running setup.py (path:/tmp/pip-Rag954-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48:06 INFO - Running setup.py (path:/tmp/pip-y9M3QQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48:06 INFO - Running setup.py (path:/tmp/pip-YjqG7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48:06 INFO - Running setup.py (path:/tmp/pip-yHQmkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48:06 INFO - Running setup.py (path:/tmp/pip-l6lhJS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48:06 INFO - Running setup.py (path:/tmp/pip-M1fmqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48:06 INFO - Running setup.py (path:/tmp/pip-VN4Kkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48:06 INFO - Running setup.py (path:/tmp/pip-IYkLX9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48:06 INFO - Running setup.py (path:/tmp/pip-roqEhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48:06 INFO - Running setup.py (path:/tmp/pip-wPnKpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48:06 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)) 13:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48:06 INFO - Running setup.py (path:/tmp/pip-sZ8ghB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48:07 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)) 13:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:07 INFO - Running setup.py (path:/tmp/pip-3Nbcay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:07 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)) 13:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:07 INFO - Running setup.py (path:/tmp/pip-eGfLRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:07 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)) 13:48:07 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)) 13:48:07 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)) 13:48:07 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)) 13:48:07 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)) 13:48:07 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)) 13:48:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:48:07 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 13:48:07 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 13:48:07 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 13:48:07 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 13:48:07 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 13:48:07 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 13:48:08 INFO - Downloading blessings-1.5.1.tar.gz 13:48:08 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 13:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:48:08 INFO - Installing collected packages: blessings 13:48:08 INFO - Running setup.py install for blessings 13:48:09 INFO - Successfully installed blessings 13:48:09 INFO - Cleaning up... 13:48:09 INFO - Return code: 0 13:48:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:48:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:48:09 INFO - Reading from file tmpfile_stdout 13:48:09 INFO - Current package versions: 13:48:09 INFO - argparse == 1.2.1 13:48:09 INFO - blessings == 1.5.1 13:48:09 INFO - blobuploader == 1.2.4 13:48:09 INFO - docopt == 0.6.1 13:48:09 INFO - manifestparser == 1.1 13:48:09 INFO - mozInstall == 1.12 13:48:09 INFO - mozcrash == 0.16 13:48:09 INFO - mozdebug == 0.1 13:48:09 INFO - mozdevice == 0.47 13:48:09 INFO - mozfile == 1.2 13:48:09 INFO - mozhttpd == 0.7 13:48:09 INFO - mozinfo == 0.9 13:48:09 INFO - mozleak == 0.1 13:48:09 INFO - mozlog == 3.1 13:48:09 INFO - moznetwork == 0.27 13:48:09 INFO - mozprocess == 0.22 13:48:09 INFO - mozprofile == 0.27 13:48:09 INFO - mozrunner == 6.11 13:48:09 INFO - mozscreenshot == 0.1 13:48:09 INFO - mozsystemmonitor == 0.0 13:48:09 INFO - moztest == 0.7 13:48:09 INFO - mozversion == 1.4 13:48:09 INFO - psutil == 3.1.1 13:48:09 INFO - requests == 1.2.3 13:48:09 INFO - wsgiref == 0.1.2 13:48:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:09 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:48:09 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 13:48:09 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 13:48:09 INFO - Using env: {'DISPLAY': ':0', 13:48:09 INFO - 'HOME': '/home/cltbld', 13:48:09 INFO - 'LANG': 'en_US.UTF-8', 13:48:09 INFO - 'LANGUAGE': 'en_US:en', 13:48:09 INFO - 'LOGNAME': 'cltbld', 13:48:09 INFO - 'MAIL': '/var/mail/cltbld', 13:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:09 INFO - 'MOZ_NO_REMOTE': '1', 13:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:09 INFO - 'NO_EM_RESTART': '1', 13:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:09 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:09 INFO - 'SHELL': '/bin/bash', 13:48:09 INFO - 'SHLVL': '1', 13:48:09 INFO - 'TERM': 'linux', 13:48:09 INFO - 'TMOUT': '86400', 13:48:09 INFO - 'USER': 'cltbld', 13:48:09 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:09 INFO - '_': '/tools/buildbot/bin/python'} 13:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 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)) 13:48:09 INFO - Cleaning up... 13:48:09 INFO - Return code: 0 13:48:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:09 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:48:09 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 13:48:09 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 13:48:09 INFO - Using env: {'DISPLAY': ':0', 13:48:09 INFO - 'HOME': '/home/cltbld', 13:48:09 INFO - 'LANG': 'en_US.UTF-8', 13:48:09 INFO - 'LANGUAGE': 'en_US:en', 13:48:09 INFO - 'LOGNAME': 'cltbld', 13:48:09 INFO - 'MAIL': '/var/mail/cltbld', 13:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:09 INFO - 'MOZ_NO_REMOTE': '1', 13:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:09 INFO - 'NO_EM_RESTART': '1', 13:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:09 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:09 INFO - 'SHELL': '/bin/bash', 13:48:09 INFO - 'SHLVL': '1', 13:48:09 INFO - 'TERM': 'linux', 13:48:09 INFO - 'TMOUT': '86400', 13:48:09 INFO - 'USER': 'cltbld', 13:48:09 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:09 INFO - '_': '/tools/buildbot/bin/python'} 13:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:09 INFO - Downloading/unpacking jsonschema 13:48:09 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 13:48:09 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 13:48:09 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 13:48:09 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 13:48:09 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 13:48:09 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 13:48:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:48:11 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 13:48:11 INFO - Downloading/unpacking functools32 (from jsonschema) 13:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:48:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:48:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:48:11 INFO - warning: no files found matching '*.txt' 13:48:11 INFO - no previously-included directories found matching 'build' 13:48:11 INFO - no previously-included directories found matching 'dist' 13:48:11 INFO - no previously-included directories found matching '.git*' 13:48:11 INFO - Installing collected packages: jsonschema, functools32 13:48:11 INFO - Running setup.py install for functools32 13:48:12 INFO - warning: no files found matching '*.txt' 13:48:12 INFO - no previously-included directories found matching 'build' 13:48:12 INFO - no previously-included directories found matching 'dist' 13:48:12 INFO - no previously-included directories found matching '.git*' 13:48:12 INFO - Successfully installed jsonschema functools32 13:48:12 INFO - Cleaning up... 13:48:12 INFO - Return code: 0 13:48:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:48:12 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')]} 13:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:12 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')]} 13:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:12 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 0x7fcc79d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', '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 13:48:12 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 13:48:12 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 13:48:12 INFO - Using env: {'DISPLAY': ':0', 13:48:12 INFO - 'HOME': '/home/cltbld', 13:48:12 INFO - 'LANG': 'en_US.UTF-8', 13:48:12 INFO - 'LANGUAGE': 'en_US:en', 13:48:12 INFO - 'LOGNAME': 'cltbld', 13:48:12 INFO - 'MAIL': '/var/mail/cltbld', 13:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:12 INFO - 'MOZ_NO_REMOTE': '1', 13:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:12 INFO - 'NO_EM_RESTART': '1', 13:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:12 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:12 INFO - 'SHELL': '/bin/bash', 13:48:12 INFO - 'SHLVL': '1', 13:48:12 INFO - 'TERM': 'linux', 13:48:12 INFO - 'TMOUT': '86400', 13:48:12 INFO - 'USER': 'cltbld', 13:48:12 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:12 INFO - '_': '/tools/buildbot/bin/python'} 13:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:12 INFO - Downloading/unpacking flake8 13:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:48:13 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 13:48:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:48:14 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 13:48:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:14 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 13:48:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:48:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:48:15 INFO - no previously-included directories found matching 'docs/_build' 13:48:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:48:15 INFO - Running setup.py install for pep8 13:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:48:15 INFO - no previously-included directories found matching 'docs/_build' 13:48:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:48:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:48:15 INFO - Cleaning up... 13:48:15 INFO - Return code: 0 13:48:15 INFO - Running post-action listener: _resource_record_post_action 13:48:15 INFO - Running post-action listener: _start_resource_monitoring 13:48:15 INFO - Starting resource monitoring. 13:48:15 INFO - ##### 13:48:15 INFO - ##### Running install step. 13:48:15 INFO - ##### 13:48:15 INFO - Running pre-action listener: _resource_record_pre_action 13:48:15 INFO - Running main action method: install 13:48:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:48:16 INFO - Reading from file tmpfile_stdout 13:48:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:48:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:48:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:48:16 INFO - Reading from file tmpfile_stdout 13:48:16 INFO - Output received: 13:48:16 INFO - Usage: mozinstall [options] installer 13:48:16 INFO - Options: 13:48:16 INFO - -h, --help show this help message and exit 13:48:16 INFO - -d DEST, --destination=DEST 13:48:16 INFO - Directory to install application into. [default: 13:48:16 INFO - "/builds/slave/test-pgo"] 13:48:16 INFO - --app=APP Application being installed. [default: firefox] 13:48:16 INFO - mkdir: /builds/slave/test-pgo/build/application 13:48:16 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'] 13:48:16 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 13:48:32 INFO - Reading from file tmpfile_stdout 13:48:32 INFO - Output received: 13:48:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:48:32 INFO - Running post-action listener: _resource_record_post_action 13:48:32 INFO - ##### 13:48:32 INFO - ##### Running run-tests step. 13:48:32 INFO - ##### 13:48:32 INFO - Running pre-action listener: _resource_record_pre_action 13:48:32 INFO - Running main action method: run_tests 13:48:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:48:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:48:32 INFO - Python 2.7.3 13:48:32 INFO - Return code: 0 13:48:32 INFO - grabbing minidump binary from tooltool 13:48: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')]} 13:48:32 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 0x271a350>, '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 0x271b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271b6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:48:32 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 13:48:32 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 13:48:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:48:32 INFO - Return code: 0 13:48:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:48:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:48:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:48:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:48:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:48:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:48:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:48:33 INFO - Return code: 0 13:48:33 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/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:48:33 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/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 13:48:33 INFO - Using env: {'DISPLAY': ':0', 13:48:33 INFO - 'HOME': '/home/cltbld', 13:48:33 INFO - 'LANG': 'en_US.UTF-8', 13:48:33 INFO - 'LANGUAGE': 'en_US:en', 13:48:33 INFO - 'LOGNAME': 'cltbld', 13:48:33 INFO - 'MAIL': '/var/mail/cltbld', 13:48:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:48:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:33 INFO - 'MOZ_NO_REMOTE': '1', 13:48:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:33 INFO - 'NO_EM_RESTART': '1', 13:48:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:33 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:48:33 INFO - 'SHELL': '/bin/bash', 13:48:33 INFO - 'SHLVL': '1', 13:48:33 INFO - 'TERM': 'linux', 13:48:33 INFO - 'TMOUT': '86400', 13:48:33 INFO - 'USER': 'cltbld', 13:48:33 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999', 13:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:33 INFO - '_': '/tools/buildbot/bin/python'} 13:48:33 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/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 13:48:34 INFO - mozversion INFO | application_buildid: 20151217113032 13:48:34 INFO - mozversion INFO | application_changeset: 6a2ad662612370d248530465d690785c20abcf0b 13:48:34 INFO - mozversion INFO | application_display_name: Nightly 13:48:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:48:34 INFO - mozversion INFO | application_name: Firefox 13:48:34 INFO - mozversion INFO | application_remotingname: firefox 13:48:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:48:34 INFO - mozversion INFO | application_vendor: Mozilla 13:48:34 INFO - mozversion INFO | application_version: 46.0a1 13:48:34 INFO - mozversion INFO | platform_buildid: 20151217113032 13:48:34 INFO - mozversion INFO | platform_changeset: 6a2ad662612370d248530465d690785c20abcf0b 13:48:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:48:34 INFO - mozversion INFO | platform_version: 46.0a1 13:48:34 INFO - 2015-12-17 13:48:34,128 DEBUG : using testdate: 1450388914 13:48:34 INFO - 2015-12-17 13:48:34,128 DEBUG : actual date: 1450388914 13:48:34 INFO - 2015-12-17 13:48:34,137 INFO : starting webserver on 'localhost:47279' 13:48:34 INFO - 2015-12-17 13:48:34,138 INFO : Starting test suite talos-linux64-ix-056 13:48:34 INFO - 2015-12-17 13:48:34,138 INFO : Starting test dromaeo_css 13:48:34 INFO - 2015-12-17 13:48:34,138 DEBUG : operating with platform_type : linux_ 13:48:34 INFO - 2015-12-17 13:48:34,139 INFO : Initialising browser for dromaeo_css test... 13:48:34 INFO - 2015-12-17 13:48:34,156 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpux6owJ/profile http://localhost:47279/getInfo.html 13:48:38 INFO - 2015-12-17 13:48:38,615 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:48:38 INFO - 2015-12-17 13:48:38,615 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:48:38 INFO - 2015-12-17 13:48:38,615 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:48:38 INFO - 2015-12-17 13:48:38,615 DEBUG : BROWSER_OUTPUT: __metrics 13:48:38 INFO - 2015-12-17 13:48:38,716 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] 13:48:38 INFO - 2015-12-17 13:48:38,777 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] 13:48:39 INFO - 2015-12-17 13:48:39,977 INFO : Browser initialized. 13:48:39 INFO - 2015-12-17 13:48:39,977 INFO : Running cycle 1/1 for dromaeo_css test... 13:48:39 INFO - 2015-12-17 13:48:39,978 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpux6owJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:48:51 INFO - 2015-12-17 13:48:51,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 150454272 13:48:51 INFO - 2015-12-17 13:48:51,826 DEBUG : BROWSER_OUTPUT: 13:49:43 INFO - 2015-12-17 13:49:43,157 DEBUG : BROWSER_OUTPUT: 1450388983157 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] 13:51:52 INFO - 2015-12-17 13:51:52,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47279/tests/dromaeo/cssquery-ext.html) 13:51:53 INFO - 2015-12-17 13:51:53,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 279916544 13:51:53 INFO - 2015-12-17 13:51:53,343 DEBUG : BROWSER_OUTPUT: 13:54:55 INFO - 2015-12-17 13:54:55,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/dromaeo/cssquery-ext.html (next: http://localhost:47279/tests/dromaeo/cssquery-jquery.html) 13:54:56 INFO - 2015-12-17 13:54:56,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 227844096 13:54:56 INFO - 2015-12-17 13:54:56,524 DEBUG : BROWSER_OUTPUT: 13:57:58 INFO - 2015-12-17 13:57:58,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47279/tests/dromaeo/cssquery-mootools.html) 13:57:59 INFO - 2015-12-17 13:57:59,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 221962240 13:57:59 INFO - 2015-12-17 13:57:59,002 DEBUG : BROWSER_OUTPUT: 14:01:00 INFO - 2015-12-17 14:01:00,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47279/tests/dromaeo/cssquery-prototype.html) 14:01:01 INFO - 2015-12-17 14:01:01,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 210919424 14:01:01 INFO - 2015-12-17 14:01:01,448 DEBUG : BROWSER_OUTPUT: 14:04:03 INFO - 2015-12-17 14:04:03,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47279/tests/dromaeo/cssquery-yui.html) 14:04:04 INFO - 2015-12-17 14:04:04,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 214634496 14:04:04 INFO - 2015-12-17 14:04:04,537 DEBUG : BROWSER_OUTPUT: 14:07:06 INFO - 2015-12-17 14:07:06,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/dromaeo/cssquery-yui.html (next: http://localhost:47279/tests/dromaeo/cssquery-dojo.html) 14:07:07 INFO - 2015-12-17 14:07:07,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 257261568 14:07:07 INFO - 2015-12-17 14:07:07,219 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,220 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:07:07 INFO - 2015-12-17 14:07:07,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:07:07 INFO - 2015-12-17 14:07:07,221 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:07:07 INFO - 2015-12-17 14:07:07,221 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:07:07 INFO - 2015-12-17 14:07:07,224 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3116.781825272232;3132.7807053506253;3163.4938409854426;3187.0598173538806;3211.470107432273;5156.716380599066;5178.430372659009;5226.92159617606;5246.291750613671;5286.4449232830575;5171.146760784466;5217.904240109581;5304.708241046741;5320.521153096221;5355.946440535594;4843.951560484394;4867.756612169395;4886.877828054292;4940.456549779521;4975.427825800025;4691.90616187676;4894.97552512237;4923.040007198598;4936.136176169174;4987.725675087869;4700.905981880361;4784.976075119602;4789.4971028042255;4794.5205479452125;4817.78319975602;4799.832005879777;4831.782569784368;4841.055994081155;4852.587530059949;4924.335214745999;4693.741844198567;4850.151223535867;4864.270359446076;4881.170201065792;4902.65681402302;5173.3533308336455;5173.715445650488;5179.689218646893;5183.637145399824;5197.298364720752;5754.74103665336;5755.856103597402;5762.711864406763;5773.826785196451;5774.769009239625;5678.3186017678145;5786.768529258825;5787.1608616750755;5821.7380217890295;5824.330202026778;5423.484768946983;5428.45715428454;5437.891242175135;5446.863828404282;5480.506754392084;5803.883922321615;5825.504832089235;5894.6757928314355;5908.852278692981;5923.763049477972;5482;5643.943560564342;5647.435256474319;5730.942690573041;5796.913046304308;5699.601027928005;5790.797322093791;5790.913136302959;5792.971035144881;5843.970780146157;5753.1370294456165;5785.971070144622;5788.0739081746715;5810.302763668386;5820.796272130455;5491.533219676372;5608.355039170466;5616.66300022;5771.307443106854;5801.274840644919;4396.4284642996845;4427.26950053244;4439.445069366329;4450.2434586120435;4496.100779843979;3980.2238563479846;3985.9003524911527;4003.459532963013;4014.9197016059516;4027.7986100694848;5200.97399513;5306.071437498423;5474.479924407175;5491.093969495068;5496.367917689517;5646.661200327993;5745.68398738065;5767.567432442584;5767.596268261182;5833.7374818133285;5439.619226654176;5456.154296084113;5461.699606521679;5462.7268636568015;5483.616146869681;4865.610751139971;4982.252662100714;4984.077945580007;5056.9494305057215;5104.846854594368;5829.358770535237;5884.205632239678;5914.083317085945;5915.3788852170765;5971.223740913741;5735.139729040678;5766.3080430346945;5788.189653448605;5804.738786754522;5821.825345239649;5627.0434026214825;5715.8571035724435;5759.222504961776;5827.1841942127285;5898.911516327173;5707.229524014371;5748.425157484218;5800.361960184461;5802.651840889392;5852.18069470283;5728.799492017926;5789.044807606866;5797.710114494343;5807.332156801853;5814;5444.047291724011;5595.8880822384135;5596;5678.034734095297;5692.288463942007;5515.283013208257;5596.972015139898;5603.943960560342;5637.548996080386;5643.3510146332055;5503.834884953458;5579.330480342385;5588.189712491747;5590.608657394106;5600.243967064557;5578;5592.636478628876;5644.943550564606;5696.145578163143;5697.743601537858;5366.114591092426;5410.107332290128;5452.6183167177915;5455.809046683347;5483.396826349019 14:07:07 INFO - 2015-12-17 14:07:07,224 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.9223355298069;593.6378808926555;605.1286147946957;611.6666416802842;612.3264409149933;29883.551746723788;30638.234044148907;37053.258934821286;37409;37518.43722344167;42118.57881421185;42607.14785704284;42616.360754588626;42625.57374426255;42677.35983960243;7538.396928245727;8724.08397118303;8900.73297801067;8900.753894454781;8906.287497000225;7715.267049630276;10605.204609654307;10863.45682715861;10867.402292873889;10868.45657717115;10406.791864162713;10515.316504427226;10515.791683746422;10517.894821051807;10526.473676316193;7740.806479837993;7870.763877083697;10420.062194402502;10505.31715438494;10543.683689489328;10209.744756381077;10317.43254121023;10354.068133867913;10367.844482332772;10371.585136594527;39616.20767584661;39817.80091099555;40130;40134;40244.39633405501;3144.4340018796606;3300.1089705779546;3330.317284956602;3358.345122701074;3673.5959044505084;30020.399592008256;30375;30458.238544036576;30684.693153068405;31232.063038108667;3730.1607138393915;3824.2160357127;3825.081980324702;3830.3871380579253;3915.9412608810608;405838.3285922098;407922;410394;410574;410966;57776.71111644415;58088;58240;58563.12155317674;58587.414125858195;61980.38019619836;62213.377866220755;62959.370406296264;64039.679801600694;65249.347506524326;13705.246211458267;13818.309084545732;13937.860621393656;13940.163590184622;13942.721145577032;9468.38455500404;9505.334626576074;9518.952405238068;9575.09036641518;9849.50752462374;17769.200385982662;20168;20285.391438256876;20692;20869.269575564784;7594.31651151399;7864.842703145905;7878.684852605831;7885.014373203349;7996.760097197093;942.8444306689456;973.3721749471551;1049.6431213387484;1061.3950048472298;1068.1668298727006;28099.157025289274;28555.28611784722;28713.425731485255;28838;28990.565141522893;1059.7880423915249;1067.1942683274078;1102.8290614954535;1104.7403860092872;1105.264998775805;14899.329530171168;14983.32575034126;15114.773278400833;15258;15356.923215383851;320449;324535;325747;326159;326212;51393.229101563506;51647;51861.48138518642;51913.2213016805;51938.22092668613;1286.3568215892053;1291.735194285188;1293.618382577142;1304.1523010043547;1313.8029295605736;27197.59203611987;28216.85891570529;28376.28685831824;28499.572506412835;28718.138455846358;45924.770376147906;46373.76813115913;46456;46477.3028404581;46509.3023604653;311446;313603;315341;315445;315499;27268.323947727204;27615.58576621312;27997.160085197476;28048.71951280461;28084.157475275773;37043.814780925924;40805.79597101996;41010.794946026275;41215.587844122376;41400.79299603483;34050;34481;34614.30771384609;35070.29859402747;35567.28865422625;34959;35155;35407.11482212862;35492.82253588716;35575.288494229455;30360;30676.84661576678;30981.69018309878;34375.484367734;35321.293574127856;30415.935442259415;31515.369692606477;31642.841785790923;31692.366152677278;31876;24037;24263.51472970566;24415.267541973768;24878.37804054913;24892.37769055788 14:07:07 INFO - 2015-12-17 14:07:07,228 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.19647801252165;353.98761043363487;358.86542546545047;360.245286125567;362.09837504613506;13997.860021399783;14363.71272574548;16152.273147708353;16350.509484715463;17020.659586808273;11729.70675733107;12291.631251062483;13870.861291387084;14357.0667906586;14450.566483005527;5278.524932756051;5398.676079435227;5409.5672346212405;5427.104527752916;5431.131019036955;4026.0740029793164;4126.484189476316;5317.548008419289;5414.160805075219;5456.045192091388;5865.7360418781045;6070.5447091468095;6089.573729838913;6097.359777223394;6099.847503812418;5915.438033386843;6027.9752442084955;6045.063015232646;6066.514678825683;6075.17985072014;5334.493223143834;5346.599005074635;5367.060764366221;5367.275417818583;5373.75818088183;19570.412887613395;19751.80248197514;19944.90027549853;20025;20191.798082019286;2173.0981642618294;2212.966805497919;2291.472961218929;2313.34069790109;2666.8266562673366;12537.93731031339;12861.87138128616;12867.87132128676;13225.801612975813;13310.401031953488;1826.8629852760964;1832.4869036669754;1835.2567210279858;1845.2711179084322;1856.6193930244267;56575;58223.12665310024;58389.41610583925;58650;59177;9395.718128456158;9538;9732.70801875945;9756.658516951873;9793.755156121011;12701.555445559361;12712.55506057302;12717.872821271669;12727.936360318325;12766.234025958473;6446.677666116675;6575.638339891352;6626.271110177877;6634.933650663528;7288.416926645856;6036.396360364016;6048.213732214784;6095.146679464879;6102.084687296941;6109.114178444101;4369.47566292047;4401.823927042882;4452.109578084332;4459.130469558405;4493.191225579427;1576.3221814619824;1597.672477142183;1764.8323409276097;1784.7412125242026;1827.9817201828077;921.7004473546124;923.6443969071955;929.5816882402946;934.4720233068294;1048.219076787798;16302.83697163037;16532.338706451606;16940.06829624358;17120.828791711923;17180;846.9195426434479;915.9954200228956;936.8688383626297;942.6512190489562;950.9904900951041;8908.242799361997;9102.317326200562;9155.81688366229;9213.216876565568;9257;344980;388535;388728;396690;407863;61808.38191618026;68440.6577967107;69954;71830.28169718236;72457;1188.1623455463878;1191.9761604767857;1194.2714943884223;1211.666791632308;1219.554862475208;14826;15447.768283475532;15615.453459128876;15673.137977410895;15689.843101568838;34442.48336274908;34661.48007779936;34785.82607086949;35445.29109417849;35612.821935890155;45695.31457028081;46077.539224607324;46214.075718486114;47393.52606473891;51397.7430112862;9356.812863742824;9541.856872147062;9656.27577931672;9658.034196580285;9662.275329350467;11364.602238921598;16816.495505134866;17224.82775172232;17533.561660958578;17652.470425887244;14287.64280892986;14359.712805744035;14418.855811441752;14633.560993170222;14803.92598037003;13483.393247304091;14036.087654302437;14313.713725725636;14376.209308487716;14488.855111449173;14066.507672231422;14141.292935353396;14360.35378407995;14528.20094894791;14937.62655933567;9249;9439.575219115019;9484.241260699266;9733.318667693193;9735.318527702993;13903.443862245396;14082.859171408154;14186.077904936146;14435.061720988102;14554 14:07:07 INFO - 2015-12-17 14:07:07,229 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1555.2923419843971;1690.5090987111614;1714.331410749808;1723.2331612432465;1762.9206685699141;6471.223453185618;7162.892556611649;7539.547627142361;7557.546547207165;7581.962090189541;7345.963270183655;7469.925300746991;7483.812904677372;7485.925140748591;7497.212792656775;1888.4806678163477;1922.8557858160625;1925.528245579835;2150.9139634414646;2172.4460262633083;2147.6778483227563;2175.934721958336;2176.270949232009;2179.7384313882276;2182.967255491169;2099.4751312171957;2127.0747224957195;2220.4892874638845;2221.0116498158327;2222.277759728087;2171.945701357463;2177.8693278403266;2205.8125059369972;2205.911763529465;2216.822654187661;2213.3802535289983;2238.317313219484;2240.372695645222;2241.641337386027;2243.2036626997506;7541.283578060075;7576.318131368148;7590.58251796151;7593.9240607593765;7609.467337286392;4567.474740404863;4591.449026116854;4596.816127354902;4598.79305431253;4657.254839225741;2991.790574659775;2998.920388660081;3042.923926901823;3058.801177923428;3078.9538156927665;978.8923218445965;990.1089019882164;1027.4451796030135;1043.4782608695652;1096.7203363142428;9966.9501652492;9986.850197247048;9986.950065249699;9996.40021598699;10010.54952527138;4136.937945930814;4165.937510937339;4261.296886013773;4272.423222864935;4282.229198744256;8624.913750862537;8682.739517814476;8683.869741953877;8721.60752766127;8725.650973961097;4570.268756998864;4606.447226332862;4609.170349337084;4620.237660786;4624.190766615829;4161.0845613964875;4224.218519573888;4224.4508213931995;4225.070484493406;4227.365895115696;3294.9176270593425;3336.4494858348103;3396.4565669492763;3448.8792892248653;3458.066322093021;1134.2003887259461;1138.2771939818274;1141.8173092305192;1144.370596172102;1145.4673576786834;976.8534719792088;980.9895807318474;1038.8337865941412;1039.0233180810014;1103.1836441033577;7182.317679820409;7258.056452661121;7265.673044713;7279.818004549928;7282.635868206568;1025.374521541859;1028.4908970059869;1044.2690116918188;1113.5100555755441;1136.471540733563;5668.433156684381;5707.771689132472;5727.083666613322;5737.340205876294;5750.396208398141;8748.256398206224;9039.81920361589;9130.863037054449;9224.169824715807;9228;8835.823283534293;9010.098990100938;9038.09619038104;9069.954650226706;9070.773230669287;6746.595204287661;6760.087388202628;6849.965750171217;6860.1081859358965;7000.614966176808;6713.12729345182;6889.311068893271;6923.723051077901;6924.861502770017;6929.341712537301;7943.24539168778;8000.15998320168;8059.959700201462;8240.01119865596;8255.25702686737;8157.34741220689;8191.959040204761;8236.629351679068;8387.287080598218;8421.747347579583;6088.543359248163;6469.223693156851;6541.116949211795;6589.24223714279;6594.505412094016;6384;6459.741610335534;6467.514936379885;6879.484038697218;7337.779866604011;6854.760083397057;6914.412274956685;6963.373296403348;7017.649117544001;7028.051213086168;6810.9318906810295;6843.349881761224;6851.417629501549;6958.582485050913;6981.127359080115;6944.756933507303;6954.269801670752;6956.965215173892;6958.095447591781;6971.65141742921;5968.850778730566;6105.084237364431;6148.3236843948025;6345.270293916259;6402.455791257796;6498.805035848932;6536.182977127859;6538.1500404947055;6540.117084193573;6544.3782840630065 14:07:07 INFO - 2015-12-17 14:07:07,233 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.39765217912117;345.08208166277706;349.2351749668228;351.3412351840299;355.3461630599696;5766.192733017381;5912.497437717789;5931.970340148298;5979.431953964372;5997.37027612101;5765.077587585987;5846.21076154719;5871.76512939483;5883.441073098049;5911.556633252512;4581.473130589975;4592.678512504126;4593.839215627454;4595.035042641032;4596.517365676606;4378.759168245745;4455.264881294583;4472.284434490482;4557.726536407826;4595.195840727859;4518.864434066967;4528.071745292207;4528.479224889131;4546.272596384579;4552.385427967231;4538.251188553884;4541.818327266906;4551.021530370953;4559.042601053783;4561;4002.459667944819;4012.1173341865033;4016.3373043447796;4025.5910431349084;4032.2741906456827;5573.749181286852;5671.858203544944;5683.602147849652;5717.942820571782;5718.5711071669375;5273.683578985235;5274.472552744734;5278.9208161877605;5279.340082489689;5284;6079.908801367983;6346.0798184263485;6346.682665866688;6348.714307856158;6358.586691865014;4280.336547835091;4297.39836422901;4390.100029493978;4391.758453285068;4401.779911004437;6517.804465866032;6521.739130434777;6553.082568440422;6563.310852360529;6601;4467.15124126415;4473.709208901411;4475.239209334421;4482.036362182146;4494.77526123699;4442.53353397895;4507.3689683444345;4538.04701012791;4540.750258735801;4559.521250268674;5221.530062294411;5246.265522826808;5251.36983561975;5255.658382205144;5269.446708095671;6308.274548426898;6311.810645680545;6358.554901156875;6362.268339141058;6386.361363863576;1584.8494393032643;1602.9679406411806;1603.8556529912364;1604.3903316739563;1606.5421354913794;1042.593388578455;1044.9268551201494;1064.3347907557777;1065.9520321585546;1074.140687450037;6116.418940200674;6131.172291740647;6144.662043587557;6145.600535965148;6149.723262453201;6565.967170164118;6567.408933196035;6572.07990881277;6574.243961944438;6580.21037475506;5998.640081595118;6049.485793707584;6079.966405711039;6128.969355153285;6136.048912418582;3534.204803919149;3550.3609350316674;3554.040409089583;3575.1955809943074;3582.408902531053;6590.275069742324;6603.70283337251;6633.502487313471;6644.368784965421;6660.70026848793;6565;6680.465562754968;6709.094272273278;6710.094137291403;6710.798676039727;6581.83545411359;6636.900446493307;6645.767398141042;6647.468202543785;6670.733170673118;6355.650439225887;6473.514486413632;6498.545101842826;6560.868782624416;6563.901541476786;6399.200099987502;6543.803685889431;6551.050097735706;6571.605703657796;6583.736650533925;6727.629980351127;6727.663616819237;6733.595984240961;6733.898991515033;6735.766831920803;4344.761038142932;4430.933535997027;4432.180046691373;4438.335624140947;4440.444944381952;6611.636360000054;6614.735410583523;6624.238212605419;6626.072349870926;6628;6440.9033864493;6443.581167224115;6448.742050317935;6448.806535803933;6456.418922297016;6293.150424692608;6362.713677884413;6422.42198202164;6428.035794630656;6434.356564343529;6312.400321969406;6313.747450101944;6319.273283572448;6320.209973753281;6324.146240257506;6461.838454038499;6462.644554549545;6471.417572418317;6478.6760661967655;6481.740730370732;6202.751889924352;6305.716242768995;6313.589616674902;6317.6209427434505;6328.398802113792 14:07:07 INFO - 2015-12-17 14:07:07,233 DEBUG : BROWSER_OUTPUT: |5;yui.html;765.2347652347653;835.2900034970276;847.665172256959;860.6385318166369;867.2151702709047;13330.800037999426;13656.453741850326;13703.38334774935;13725.93137034316;13773.724525509497;12866.742665146692;12975.286359250238;12977.221366718004;12989.285589292585;12993.155444896076;680.2958937499689;686.8557602903396;811.4117264982899;818.2145140664969;835.0480452284401;828.2090603473698;829.5147338806775;830.4726498673325;835.7116794705847;836.2849763452252;851.9659213631447;857.695518091075;860.3074525007366;861.8879545659056;863.3567991846083;694.2536772969053;695.1067877777058;836.8075342671159;859.497194141428;862.8015556421996;635.3551145587232;635.517007074622;635.9682015899186;637.4740838808002;640.3596403596404;13206.207627542282;13213.471461141542;13227.537036203783;13242.735145297136;13261;12079.214851034654;12082;12435.689107772288;12462.12765106443;12548.372581370895;10143.543540540619;10193.541290641864;10418.739531511697;10427.791444171075;10464.843027354596;3463.9134021649406;3515.8837268367524;3547.9822600886832;3561.056320075182;3591.892243232707;43298.78350608258;43734.781326093485;43767.99999999968;44092;44432;8880.644774209088;8917.643294268157;9101.863472047924;9104.317176211678;9187.897452305633;17269.56826079358;17375.218115184845;17432.5641858952;17444.389446369318;17511.38710145139;7323.231060738653;7409.777706668809;7420.5547667140145;7523.699052037857;7815.57014364204;3904.2386734587053;3970.900727481778;4033.899152521152;4093.3041382964966;4103.707332190351;3021.9093427197217;3045.9390812183633;3068.923276918095;3071.953920691147;3080.661127276043;499.4880247746017;503.8564009257344;510.04621358060666;511.97952081916304;522.9843104706865;552.8203333916413;624.1636207481905;631.3395769127258;654.1496055128314;708.5323686366974;8061.234182752629;8162.347012239006;8402.789930251793;8505;8686.913130868737;665.2582370656779;682.6211452643731;682.6962001909202;688.4251649872413;698.4866123399297;3949.8025098744947;4028.71798974069;4059.3505039193587;4103.076807718299;4106.240345536085;54361;55147.38231412176;55414.72292638592;55546;55551;48636;49550.50449495531;53047.73476132672;53871.73064134654;55018.17472737912;44912.326315105296;45258.32112518381;45312.546874531494;45388.3191752124;45673;8730.56347182651;8825.205731484197;8965.282777377664;8979.730608081769;8982.595783189903;34988.650113499556;35679.464808027384;35682.82158589294;35739;35752.64247357597;44863.775681121384;45015.324770127816;45112;45702;46034.30948535842;10535.051845333957;10902.454877256265;10914.290571112851;11049.226554141133;11236.494357753758;12260.448279827251;12351;12456.937715311728;12542.874571254171;12601.558945436866;11467.713307167387;11784.116191285517;12003.819942700691;12120.939395302967;12212.08409369283;11164.218504704593;11292.943535282271;11719.238249513754;11732.237404568676;11861.05111591088;10601.840972385266;10715.303505272132;10833.620823271147;11387.772244555228;11489;10023.498825058863;10174.13519850821;10226.148480518219;10350.482475876326;10405.583776649151;9492.477913714813;9789;9860.16188623975;9946.154576861049;9993.400395976265 14:07:07 INFO - 2015-12-17 14:07:07,233 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:07:07 INFO - 2015-12-17 14:07:07,234 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:07:07 INFO - 2015-12-17 14:07:07,234 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1057 14:07:07 INFO - 2015-12-17 14:07:07,234 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:07:07 INFO - 2015-12-17 14:07:07,234 DEBUG : BROWSER_OUTPUT: __startTimestamp1450390027219__endTimestamp 14:07:07 INFO - 2015-12-17 14:07:07,235 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,235 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:07:07 INFO - 2015-12-17 14:07:07,235 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:07:07 INFO - 2015-12-17 14:07:07,235 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,236 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5326.19 Median:5496.37 stddev:596.06 (10.8%) stddev-sans-first:572.13 14:07:07 INFO - 2015-12-17 14:07:07,237 DEBUG : BROWSER_OUTPUT: Values: 3116.8 3132.8 3163.5 3187.1 3211.5 5156.7 5178.4 5226.9 5246.3 5286.4 5171.1 5217.9 5304.7 5320.5 5355.9 4844.0 4867.8 4886.9 4940.5 4975.4 4691.9 4895.0 4923.0 4936.1 4987.7 4700.9 4785.0 4789.5 4794.5 4817.8 4799.8 4831.8 4841.1 4852.6 4924.3 4693.7 4850.2 4864.3 4881.2 4902.7 5173.4 5173.7 5179.7 5183.6 5197.3 5754.7 5755.9 5762.7 5773.8 5774.8 5678.3 5786.8 5787.2 5821.7 5824.3 5423.5 5428.5 5437.9 5446.9 5480.5 5803.9 5825.5 5894.7 5908.9 5923.8 5482.0 5643.9 5647.4 5730.9 5796.9 5699.6 5790.8 5790.9 5793.0 5844.0 5753.1 5786.0 5788.1 5810.3 5820.8 5491.5 5608.4 5616.7 5771.3 5801.3 4396.4 4427.3 4439.4 4450.2 4496.1 3980.2 3985.9 4003.5 4014.9 4027.8 5201.0 5306.1 5474.5 5491.1 5496.4 5646.7 5745.7 5767.6 5767.6 5833.7 5439.6 5456.2 5461.7 5462.7 5483.6 4865.6 4982.3 4984.1 5056.9 5104.8 5829.4 5884.2 5914.1 5915.4 5971.2 5735.1 5766.3 5788.2 5804.7 5821.8 5627.0 5715.9 5759.2 5827.2 5898.9 5707.2 5748.4 5800.4 5802.7 5852.2 5728.8 5789.0 5797.7 5807.3 5814.0 5444.0 5595.9 5596.0 5678.0 5692.3 5515.3 5597.0 5603.9 5637.5 5643.4 5503.8 5579.3 5588.2 5590.6 5600.2 5578.0 5592.6 5644.9 5696.1 5697.7 5366.1 5410.1 5452.6 5455.8 5483.4 14:07:07 INFO - 2015-12-17 14:07:07,237 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,238 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50697.09 Median:164756.05 stddev:92662.62 (56.2%) stddev-sans-first:92846.07 14:07:07 INFO - 2015-12-17 14:07:07,239 DEBUG : BROWSER_OUTPUT: Values: 549.9 593.6 605.1 611.7 612.3 29883.6 30638.2 37053.3 37409.0 37518.4 42118.6 42607.1 42616.4 42625.6 42677.4 7538.4 8724.1 8900.7 8900.8 8906.3 7715.3 10605.2 10863.5 10867.4 10868.5 10406.8 10515.3 10515.8 10517.9 10526.5 7740.8 7870.8 10420.1 10505.3 10543.7 10209.7 10317.4 10354.1 10367.8 10371.6 39616.2 39817.8 40130.0 40134.0 40244.4 3144.4 3300.1 3330.3 3358.3 3673.6 30020.4 30375.0 30458.2 30684.7 31232.1 3730.2 3824.2 3825.1 3830.4 3915.9 405838.3 407922.0 410394.0 410574.0 410966.0 57776.7 58088.0 58240.0 58563.1 58587.4 61980.4 62213.4 62959.4 64039.7 65249.3 13705.2 13818.3 13937.9 13940.2 13942.7 9468.4 9505.3 9519.0 9575.1 9849.5 17769.2 20168.0 20285.4 20692.0 20869.3 7594.3 7864.8 7878.7 7885.0 7996.8 942.8 973.4 1049.6 1061.4 1068.2 28099.2 28555.3 28713.4 28838.0 28990.6 1059.8 1067.2 1102.8 1104.7 1105.3 14899.3 14983.3 15114.8 15258.0 15356.9 320449.0 324535.0 325747.0 326159.0 326212.0 51393.2 51647.0 51861.5 51913.2 51938.2 1286.4 1291.7 1293.6 1304.2 1313.8 27197.6 28216.9 28376.3 28499.6 28718.1 45924.8 46373.8 46456.0 46477.3 46509.3 311446.0 313603.0 315341.0 315445.0 315499.0 27268.3 27615.6 27997.2 28048.7 28084.2 37043.8 40805.8 41010.8 41215.6 41400.8 34050.0 34481.0 34614.3 35070.3 35567.3 34959.0 35155.0 35407.1 35492.8 35575.3 30360.0 30676.8 30981.7 34375.5 35321.3 30415.9 31515.4 31642.8 31692.4 31876.0 24037.0 24263.5 24415.3 24878.4 24892.4 14:07:07 INFO - 2015-12-17 14:07:07,239 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,239 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24085.17 Median:361.17 stddev:63220.03 (17504.1%) stddev-sans-first:63372.26 14:07:07 INFO - 2015-12-17 14:07:07,241 DEBUG : BROWSER_OUTPUT: Values: 353.2 354.0 358.9 360.2 362.1 13997.9 14363.7 16152.3 16350.5 17020.7 11729.7 12291.6 13870.9 14357.1 14450.6 5278.5 5398.7 5409.6 5427.1 5431.1 4026.1 4126.5 5317.5 5414.2 5456.0 5865.7 6070.5 6089.6 6097.4 6099.8 5915.4 6028.0 6045.1 6066.5 6075.2 5334.5 5346.6 5367.1 5367.3 5373.8 19570.4 19751.8 19944.9 20025.0 20191.8 2173.1 2213.0 2291.5 2313.3 2666.8 12537.9 12861.9 12867.9 13225.8 13310.4 1826.9 1832.5 1835.3 1845.3 1856.6 56575.0 58223.1 58389.4 58650.0 59177.0 9395.7 9538.0 9732.7 9756.7 9793.8 12701.6 12712.6 12717.9 12727.9 12766.2 6446.7 6575.6 6626.3 6634.9 7288.4 6036.4 6048.2 6095.1 6102.1 6109.1 4369.5 4401.8 4452.1 4459.1 4493.2 1576.3 1597.7 1764.8 1784.7 1828.0 921.7 923.6 929.6 934.5 1048.2 16302.8 16532.3 16940.1 17120.8 17180.0 846.9 916.0 936.9 942.7 951.0 8908.2 9102.3 9155.8 9213.2 9257.0 344980.0 388535.0 388728.0 396690.0 407863.0 61808.4 68440.7 69954.0 71830.3 72457.0 1188.2 1192.0 1194.3 1211.7 1219.6 14826.0 15447.8 15615.5 15673.1 15689.8 34442.5 34661.5 34785.8 35445.3 35612.8 45695.3 46077.5 46214.1 47393.5 51397.7 9356.8 9541.9 9656.3 9658.0 9662.3 11364.6 16816.5 17224.8 17533.6 17652.5 14287.6 14359.7 14418.9 14633.6 14803.9 13483.4 14036.1 14313.7 14376.2 14488.9 14066.5 14141.3 14360.4 14528.2 14937.6 9249.0 9439.6 9484.2 9733.3 9735.3 13903.4 14082.9 14186.1 14435.1 14554.0 14:07:07 INFO - 2015-12-17 14:07:07,241 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,241 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5267.56 Median:6468.37 stddev:2700.33 (41.7%) stddev-sans-first:2693.49 14:07:07 INFO - 2015-12-17 14:07:07,242 DEBUG : BROWSER_OUTPUT: Values: 1555.3 1690.5 1714.3 1723.2 1762.9 6471.2 7162.9 7539.5 7557.5 7582.0 7346.0 7469.9 7483.8 7485.9 7497.2 1888.5 1922.9 1925.5 2150.9 2172.4 2147.7 2175.9 2176.3 2179.7 2183.0 2099.5 2127.1 2220.5 2221.0 2222.3 2171.9 2177.9 2205.8 2205.9 2216.8 2213.4 2238.3 2240.4 2241.6 2243.2 7541.3 7576.3 7590.6 7593.9 7609.5 4567.5 4591.4 4596.8 4598.8 4657.3 2991.8 2998.9 3042.9 3058.8 3079.0 978.9 990.1 1027.4 1043.5 1096.7 9967.0 9986.9 9987.0 9996.4 10010.5 4136.9 4165.9 4261.3 4272.4 4282.2 8624.9 8682.7 8683.9 8721.6 8725.7 4570.3 4606.4 4609.2 4620.2 4624.2 4161.1 4224.2 4224.5 4225.1 4227.4 3294.9 3336.4 3396.5 3448.9 3458.1 1134.2 1138.3 1141.8 1144.4 1145.5 976.9 981.0 1038.8 1039.0 1103.2 7182.3 7258.1 7265.7 7279.8 7282.6 1025.4 1028.5 1044.3 1113.5 1136.5 5668.4 5707.8 5727.1 5737.3 5750.4 8748.3 9039.8 9130.9 9224.2 9228.0 8835.8 9010.1 9038.1 9070.0 9070.8 6746.6 6760.1 6850.0 6860.1 7000.6 6713.1 6889.3 6923.7 6924.9 6929.3 7943.2 8000.2 8060.0 8240.0 8255.3 8157.3 8192.0 8236.6 8387.3 8421.7 6088.5 6469.2 6541.1 6589.2 6594.5 6384.0 6459.7 6467.5 6879.5 7337.8 6854.8 6914.4 6963.4 7017.6 7028.1 6810.9 6843.3 6851.4 6958.6 6981.1 6944.8 6954.3 6957.0 6958.1 6971.7 5968.9 6105.1 6148.3 6345.3 6402.5 6498.8 6536.2 6538.2 6540.1 6544.4 14:07:07 INFO - 2015-12-17 14:07:07,242 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,243 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5297.29 Median:6024.06 stddev:1600.19 (26.6%) stddev-sans-first:1560.79 14:07:07 INFO - 2015-12-17 14:07:07,243 DEBUG : BROWSER_OUTPUT: Values: 338.4 345.1 349.2 351.3 355.3 5766.2 5912.5 5932.0 5979.4 5997.4 5765.1 5846.2 5871.8 5883.4 5911.6 4581.5 4592.7 4593.8 4595.0 4596.5 4378.8 4455.3 4472.3 4557.7 4595.2 4518.9 4528.1 4528.5 4546.3 4552.4 4538.3 4541.8 4551.0 4559.0 4561.0 4002.5 4012.1 4016.3 4025.6 4032.3 5573.7 5671.9 5683.6 5717.9 5718.6 5273.7 5274.5 5278.9 5279.3 5284.0 6079.9 6346.1 6346.7 6348.7 6358.6 4280.3 4297.4 4390.1 4391.8 4401.8 6517.8 6521.7 6553.1 6563.3 6601.0 4467.2 4473.7 4475.2 4482.0 4494.8 4442.5 4507.4 4538.0 4540.8 4559.5 5221.5 5246.3 5251.4 5255.7 5269.4 6308.3 6311.8 6358.6 6362.3 6386.4 1584.8 1603.0 1603.9 1604.4 1606.5 1042.6 1044.9 1064.3 1066.0 1074.1 6116.4 6131.2 6144.7 6145.6 6149.7 6566.0 6567.4 6572.1 6574.2 6580.2 5998.6 6049.5 6080.0 6129.0 6136.0 3534.2 3550.4 3554.0 3575.2 3582.4 6590.3 6603.7 6633.5 6644.4 6660.7 6565.0 6680.5 6709.1 6710.1 6710.8 6581.8 6636.9 6645.8 6647.5 6670.7 6355.7 6473.5 6498.5 6560.9 6563.9 6399.2 6543.8 6551.1 6571.6 6583.7 6727.6 6727.7 6733.6 6733.9 6735.8 4344.8 4430.9 4432.2 4438.3 4440.4 6611.6 6614.7 6624.2 6626.1 6628.0 6440.9 6443.6 6448.7 6448.8 6456.4 6293.2 6362.7 6422.4 6428.0 6434.4 6312.4 6313.7 6319.3 6320.2 6324.1 6461.8 6462.6 6471.4 6478.7 6481.7 6202.8 6305.7 6313.6 6317.6 6328.4 14:07:07 INFO - 2015-12-17 14:07:07,244 DEBUG : BROWSER_OUTPUT: 14:07:07 INFO - 2015-12-17 14:07:07,244 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13614.21 Median:44888.05 stddev:15585.70 (34.7%) stddev-sans-first:15599.55 14:07:07 INFO - 2015-12-17 14:07:07,245 DEBUG : BROWSER_OUTPUT: Values: 765.2 835.3 847.7 860.6 867.2 13330.8 13656.5 13703.4 13725.9 13773.7 12866.7 12975.3 12977.2 12989.3 12993.2 680.3 686.9 811.4 818.2 835.0 828.2 829.5 830.5 835.7 836.3 852.0 857.7 860.3 861.9 863.4 694.3 695.1 836.8 859.5 862.8 635.4 635.5 636.0 637.5 640.4 13206.2 13213.5 13227.5 13242.7 13261.0 12079.2 12082.0 12435.7 12462.1 12548.4 10143.5 10193.5 10418.7 10427.8 10464.8 3463.9 3515.9 3548.0 3561.1 3591.9 43298.8 43734.8 43768.0 44092.0 44432.0 8880.6 8917.6 9101.9 9104.3 9187.9 17269.6 17375.2 17432.6 17444.4 17511.4 7323.2 7409.8 7420.6 7523.7 7815.6 3904.2 3970.9 4033.9 4093.3 4103.7 3021.9 3045.9 3068.9 3072.0 3080.7 499.5 503.9 510.0 512.0 523.0 552.8 624.2 631.3 654.1 708.5 8061.2 8162.3 8402.8 8505.0 8686.9 665.3 682.6 682.7 688.4 698.5 3949.8 4028.7 4059.4 4103.1 4106.2 54361.0 55147.4 55414.7 55546.0 55551.0 48636.0 49550.5 53047.7 53871.7 55018.2 44912.3 45258.3 45312.5 45388.3 45673.0 8730.6 8825.2 8965.3 8979.7 8982.6 34988.7 35679.5 35682.8 35739.0 35752.6 44863.8 45015.3 45112.0 45702.0 46034.3 10535.1 10902.5 10914.3 11049.2 11236.5 12260.4 12351.0 12456.9 12542.9 12601.6 11467.7 11784.1 12003.8 12120.9 12212.1 11164.2 11292.9 11719.2 11732.2 11861.1 10601.8 10715.3 10833.6 11387.8 11489.0 10023.5 10174.1 10226.1 10350.5 10405.6 9492.5 9789.0 9860.2 9946.2 9993.4 14:07:07 INFO - 2015-12-17 14:07:07,246 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:07:07 INFO - 2015-12-17 14:07:07,246 DEBUG : BROWSER_OUTPUT: 14:07:08 INFO - 2015-12-17 14:07:08,013 INFO : Browser exited with error code: 0 14:07:08 INFO - 2015-12-17 14:07:08,036 INFO : Completed test dromaeo_css (00:18:33) 14:07:08 INFO - 2015-12-17 14:07:08,037 INFO : Starting test kraken 14:07:08 INFO - 2015-12-17 14:07:08,037 DEBUG : operating with platform_type : linux_ 14:07:08 INFO - 2015-12-17 14:07:08,037 INFO : Initialising browser for kraken test... 14:07:08 INFO - 2015-12-17 14:07:08,043 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvVb7Td/profile http://localhost:47279/getInfo.html 14:07:12 INFO - 2015-12-17 14:07:12,328 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:07:12 INFO - 2015-12-17 14:07:12,328 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:07:12 INFO - 2015-12-17 14:07:12,328 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:07:12 INFO - 2015-12-17 14:07:12,328 DEBUG : BROWSER_OUTPUT: __metrics 14:07:12 INFO - 2015-12-17 14:07:12,425 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] 14:07:12 INFO - 2015-12-17 14:07:12,486 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] 14:07:13 INFO - 2015-12-17 14:07:13,764 INFO : Browser initialized. 14:07:13 INFO - 2015-12-17 14:07:13,764 INFO : Running cycle 1/1 for kraken test... 14:07:13 INFO - 2015-12-17 14:07:13,765 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvVb7Td/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:07:25 INFO - 2015-12-17 14:07:25,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 149725184 14:07:25 INFO - 2015-12-17 14:07:25,623 DEBUG : BROWSER_OUTPUT: 14:07:28 INFO - 2015-12-17 14:07:28,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47279/tests/kraken/driver.html?testName=audio-beat-detection) 14:07:28 INFO - 2015-12-17 14:07:28,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 185942016 14:07:28 INFO - 2015-12-17 14:07:28,706 DEBUG : BROWSER_OUTPUT: 14:07:31 INFO - 2015-12-17 14:07:31,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47279/tests/kraken/driver.html?testName=audio-dft) 14:07:31 INFO - 2015-12-17 14:07:31,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 175517696 14:07:31 INFO - 2015-12-17 14:07:31,877 DEBUG : BROWSER_OUTPUT: 14:07:34 INFO - 2015-12-17 14:07:34,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47279/tests/kraken/driver.html?testName=audio-fft) 14:07:35 INFO - 2015-12-17 14:07:35,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 160903168 14:07:35 INFO - 2015-12-17 14:07:35,330 DEBUG : BROWSER_OUTPUT: 14:07:37 INFO - 2015-12-17 14:07:37,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47279/tests/kraken/driver.html?testName=audio-oscillator) 14:07:37 INFO - 2015-12-17 14:07:37,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 162508800 14:07:37 INFO - 2015-12-17 14:07:37,883 DEBUG : BROWSER_OUTPUT: 14:07:40 INFO - 2015-12-17 14:07:40,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:07:40 INFO - 2015-12-17 14:07:40,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 163287040 14:07:40 INFO - 2015-12-17 14:07:40,650 DEBUG : BROWSER_OUTPUT: 14:07:43 INFO - 2015-12-17 14:07:43,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47279/tests/kraken/driver.html?testName=imaging-darkroom) 14:07:44 INFO - 2015-12-17 14:07:44,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 164429824 14:07:44 INFO - 2015-12-17 14:07:44,096 DEBUG : BROWSER_OUTPUT: 14:07:47 INFO - 2015-12-17 14:07:47,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47279/tests/kraken/driver.html?testName=imaging-desaturate) 14:07:48 INFO - 2015-12-17 14:07:48,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 164483072 14:07:48 INFO - 2015-12-17 14:07:48,003 DEBUG : BROWSER_OUTPUT: 14:07:50 INFO - 2015-12-17 14:07:50,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47279/tests/kraken/driver.html?testName=json-parse-financial) 14:07:51 INFO - 2015-12-17 14:07:51,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 164151296 14:07:51 INFO - 2015-12-17 14:07:51,293 DEBUG : BROWSER_OUTPUT: 14:07:52 INFO - 2015-12-17 14:07:52,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:07:53 INFO - 2015-12-17 14:07:53,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 174288896 14:07:53 INFO - 2015-12-17 14:07:53,447 DEBUG : BROWSER_OUTPUT: 14:07:55 INFO - 2015-12-17 14:07:55,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:07:55 INFO - 2015-12-17 14:07:55,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 171380736 14:07:55 INFO - 2015-12-17 14:07:55,863 DEBUG : BROWSER_OUTPUT: 14:07:57 INFO - 2015-12-17 14:07:57,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:07:58 INFO - 2015-12-17 14:07:58,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 182026240 14:07:58 INFO - 2015-12-17 14:07:58,517 DEBUG : BROWSER_OUTPUT: 14:08:00 INFO - 2015-12-17 14:08:00,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:08:01 INFO - 2015-12-17 14:08:01,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 188231680 14:08:01 INFO - 2015-12-17 14:08:01,494 DEBUG : BROWSER_OUTPUT: 14:08:04 INFO - 2015-12-17 14:08:04,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:08:04 INFO - 2015-12-17 14:08:04,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 187891712 14:08:04 INFO - 2015-12-17 14:08:04,671 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47279/tests/kraken/driver.html?testName=ai-astar) 14:08:06 INFO - 2015-12-17 14:08:06,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 244461568 14:08:06 INFO - 2015-12-17 14:08:06,608 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,612 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:08:06 INFO - 2015-12-17 14:08:06,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:08:06 INFO - 2015-12-17 14:08:06,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:08:06 INFO - 2015-12-17 14:08:06,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:08:06 INFO - 2015-12-17 14:08:06,612 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;105;112;111;113;99;110;110;117 14:08:06 INFO - 2015-12-17 14:08:06,612 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;147;181;126;148;149;124;162;126 14:08:06 INFO - 2015-12-17 14:08:06,613 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;161;161;162;163;163;162;163;163 14:08:06 INFO - 2015-12-17 14:08:06,613 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;84;94;76;73;71;129;90;71 14:08:06 INFO - 2015-12-17 14:08:06,613 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;138;93;94;93;138;95;93;136 14:08:06 INFO - 2015-12-17 14:08:06,613 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;109;110;109;111 14:08:06 INFO - 2015-12-17 14:08:06,613 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;145;145;146;145;144;146;145;145 14:08:06 INFO - 2015-12-17 14:08:06,613 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;96;96;96;95 14:08:06 INFO - 2015-12-17 14:08:06,613 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;57;58;59;61;67;57;58 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;67;68;70;73;68;68;74;69 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;85;85;85;84;86;85;84;85;86 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;121;122;115;115;116;118;124;122;116 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;157;152;151;149;155;151;152;143;142 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;70;70;69;67;70;67;67;67 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:08:06 INFO - 2015-12-17 14:08:06,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 14:08:06 INFO - 2015-12-17 14:08:06,615 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:08:06 INFO - 2015-12-17 14:08:06,615 DEBUG : BROWSER_OUTPUT: __startTimestamp1450390086609__endTimestamp 14:08:06 INFO - 2015-12-17 14:08:06,615 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,618 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:08:06 INFO - 2015-12-17 14:08:06,618 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:08:06 INFO - 2015-12-17 14:08:06,618 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,618 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:4.83 (4.3%) stddev-sans-first:5.12 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 105.0 112.0 111.0 113.0 99.0 110.0 110.0 117.0 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:148.50 stddev:18.90 (12.7%) stddev-sans-first:19.94 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 147.0 181.0 126.0 148.0 149.0 124.0 162.0 126.0 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 161.0 161.0 162.0 163.0 163.0 162.0 163.0 163.0 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:18.03 (24.0%) stddev-sans-first:18.64 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 84.0 94.0 76.0 73.0 71.0 129.0 90.0 71.0 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.30 (22.9%) stddev-sans-first:21.93 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 138.0 93.0 94.0 93.0 138.0 95.0 93.0 136.0 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 14:08:06 INFO - 2015-12-17 14:08:06,619 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 111.0 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 145.0 145.0 146.0 145.0 144.0 146.0 145.0 145.0 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:2.91 (4.9%) stddev-sans-first:3.09 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 57.0 58.0 59.0 61.0 67.0 57.0 58.0 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:2.32 (3.4%) stddev-sans-first:2.40 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 68.0 70.0 73.0 68.0 68.0 74.0 69.0 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:1.72 (2.0%) stddev-sans-first:0.71 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: Values: 90.0 85.0 85.0 85.0 84.0 86.0 85.0 84.0 85.0 86.0 14:08:06 INFO - 2015-12-17 14:08:06,620 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:121.50 stddev:3.55 (2.9%) stddev-sans-first:3.49 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: Values: 123.0 121.0 122.0 115.0 115.0 116.0 118.0 124.0 122.0 116.0 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:152.00 stddev:4.84 (3.2%) stddev-sans-first:4.97 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: Values: 154.0 157.0 152.0 151.0 149.0 155.0 151.0 152.0 143.0 142.0 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 70.0 69.0 67.0 70.0 67.0 67.0 67.0 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:08:06 INFO - 2015-12-17 14:08:06,621 DEBUG : BROWSER_OUTPUT: 14:08:07 INFO - 2015-12-17 14:08:07,465 INFO : Browser exited with error code: 0 14:08:07 INFO - 2015-12-17 14:08:07,518 INFO : Completed test kraken (00:00:59) 14:08:07 INFO - 2015-12-17 14:08:07,518 INFO : Starting test v8_7 14:08:07 INFO - 2015-12-17 14:08:07,518 DEBUG : operating with platform_type : linux_ 14:08:07 INFO - 2015-12-17 14:08:07,518 INFO : Initialising browser for v8_7 test... 14:08:07 INFO - 2015-12-17 14:08:07,524 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUkdgS8/profile http://localhost:47279/getInfo.html 14:08:12 INFO - 2015-12-17 14:08:12,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:08:12 INFO - 2015-12-17 14:08:12,293 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:08:12 INFO - 2015-12-17 14:08:12,293 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:08:12 INFO - 2015-12-17 14:08:12,293 DEBUG : BROWSER_OUTPUT: __metrics 14:08:12 INFO - 2015-12-17 14:08:12,442 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] 14:08:12 INFO - 2015-12-17 14:08:12,498 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] 14:08:13 INFO - 2015-12-17 14:08:13,395 INFO : Browser initialized. 14:08:13 INFO - 2015-12-17 14:08:13,396 INFO : Running cycle 1/1 for v8_7 test... 14:08:13 INFO - 2015-12-17 14:08:13,396 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUkdgS8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:08:25 INFO - 2015-12-17 14:08:25,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 150384640 14:08:25 INFO - 2015-12-17 14:08:25,210 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47279/tests/v8_7/run.html (next: http://localhost:47279/tests/v8_7/run.html) 14:08:46 INFO - 2015-12-17 14:08:46,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 620032000 14:08:46 INFO - 2015-12-17 14:08:46,910 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,910 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:08:46 INFO - 2015-12-17 14:08:46,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:08:46 INFO - 2015-12-17 14:08:46,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:08:46 INFO - 2015-12-17 14:08:46,911 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:08:46 INFO - 2015-12-17 14:08:46,911 DEBUG : BROWSER_OUTPUT: |0;Richards;165.31658125309968 14:08:46 INFO - 2015-12-17 14:08:46,911 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.39487565938205 14:08:46 INFO - 2015-12-17 14:08:46,911 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 14:08:46 INFO - 2015-12-17 14:08:46,912 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 14:08:46 INFO - 2015-12-17 14:08:46,912 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1958.9041095890411 14:08:46 INFO - 2015-12-17 14:08:46,912 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 14:08:46 INFO - 2015-12-17 14:08:46,912 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 14:08:46 INFO - 2015-12-17 14:08:46,912 DEBUG : BROWSER_OUTPUT: |7;RegExp;25641.02564102564 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: |8;Splay;640.2048655569782 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: __startTimestamp1450390126908__endTimestamp 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.32 Median:165.32 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: Values: 165.3 14:08:46 INFO - 2015-12-17 14:08:46,913 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: Values: 188.4 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: Values: 281.0 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: Values: 5196.9 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1958.90 Median:1958.90 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,914 DEBUG : BROWSER_OUTPUT: Values: 1958.9 14:08:46 INFO - 2015-12-17 14:08:46,915 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,915 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,915 DEBUG : BROWSER_OUTPUT: Values: 786.8 14:08:46 INFO - 2015-12-17 14:08:46,915 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,915 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,916 DEBUG : BROWSER_OUTPUT: Values: 12231.7 14:08:46 INFO - 2015-12-17 14:08:46,916 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,916 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,916 DEBUG : BROWSER_OUTPUT: Values: 25641.0 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:640.20 Median:640.20 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: Values: 640.2 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:08:46 INFO - 2015-12-17 14:08:46,917 DEBUG : BROWSER_OUTPUT: 14:08:47 INFO - 2015-12-17 14:08:47,777 INFO : Browser exited with error code: 0 14:08:47 INFO - 2015-12-17 14:08:47,794 INFO : Completed test v8_7 (00:00:40) 14:08:47 INFO - 2015-12-17 14:08:47,867 INFO : Completed test suite (00:20:13) 14:08:47 INFO - 2015-12-17 14:08:47,867 DEBUG : Working with test: dromaeo_css 14:08:47 INFO - 2015-12-17 14:08:47,867 DEBUG : Generating results file: dromaeo_css 14:08:47 INFO - 2015-12-17 14:08:47,868 DEBUG : Working with test: kraken 14:08:47 INFO - 2015-12-17 14:08:47,868 DEBUG : Generating results file: kraken 14:08:47 INFO - 2015-12-17 14:08:47,869 INFO : javascript benchmark 14:08:47 INFO - 2015-12-17 14:08:47,869 DEBUG : Working with test: v8_7 14:08:47 INFO - 2015-12-17 14:08:47,869 DEBUG : Generating results file: v8_7 14:08:47 INFO - 2015-12-17 14:08:47,869 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:08:47 INFO - 2015-12-17 14:08:47,926 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:08:47 INFO - 2015-12-17 14:08:47,926 DEBUG : process_Request line: dromaeo_css 6933.83 graph.html#tests=[[72,64,35]] 14:08:47 INFO - 2015-12-17 14:08:47,926 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:08:47 INFO - 2015-12-17 14:08:47,957 DEBUG : process_Request line: kraken 1508.40 graph.html#tests=[[232,64,35]] 14:08:47 INFO - 2015-12-17 14:08:47,957 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:08:47 INFO - 2015-12-17 14:08:47,991 DEBUG : process_Request line: v8_7 19774.57 graph.html#tests=[[230,64,35]] 14:08:47 INFO - 2015-12-17 14:08:47,992 INFO : javascript benchmark 14:08:48 INFO - 2015-12-17 14:08:47,996 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3116.781825272232, 3132.7807053506253, 3163.4938409854426, 3187.0598173538806, 3211.470107432273, 5156.716380599066, 5178.430372659009, 5226.92159617606, 5246.291750613671, 5286.4449232830575, 5171.146760784466, 5217.904240109581, 5304.708241046741, 5320.521153096221, 5355.946440535594, 4843.951560484394, 4867.756612169395, 4886.877828054292, 4940.456549779521, 4975.427825800025, 4691.90616187676, 4894.97552512237, 4923.040007198598, 4936.136176169174, 4987.725675087869, 4700.905981880361, 4784.976075119602, 4789.4971028042255, 4794.5205479452125, 4817.78319975602, 4799.832005879777, 4831.782569784368, 4841.055994081155, 4852.587530059949, 4924.335214745999, 4693.741844198567, 4850.151223535867, 4864.270359446076, 4881.170201065792, 4902.65681402302, 5173.3533308336455, 5173.715445650488, 5179.689218646893, 5183.637145399824, 5197.298364720752, 5754.74103665336, 5755.856103597402, 5762.711864406763, 5773.826785196451, 5774.769009239625, 5678.3186017678145, 5786.768529258825, 5787.1608616750755, 5821.7380217890295, 5824.330202026778, 5423.484768946983, 5428.45715428454, 5437.891242175135, 5446.863828404282, 5480.506754392084, 5803.883922321615, 5825.504832089235, 5894.6757928314355, 5908.852278692981, 5923.763049477972, 5482.0, 5643.943560564342, 5647.435256474319, 5730.942690573041, 5796.913046304308, 5699.601027928005, 5790.797322093791, 5790.913136302959, 5792.971035144881, 5843.970780146157, 5753.1370294456165, 5785.971070144622, 5788.0739081746715, 5810.302763668386, 5820.796272130455, 5491.533219676372, 5608.355039170466, 5616.66300022, 5771.307443106854, 5801.274840644919, 4396.4284642996845, 4427.26950053244, 4439.445069366329, 4450.2434586120435, 4496.100779843979, 3980.2238563479846, 3985.9003524911527, 4003.459532963013, 4014.9197016059516, 4027.7986100694848, 5200.97399513, 5306.071437498423, 5474.479924407175, 5491.093969495068, 5496.367917689517, 5646.661200327993, 5745.68398738065, 5767.567432442584, 5767.596268261182, 5833.7374818133285, 5439.619226654176, 5456.154296084113, 5461.699606521679, 5462.7268636568015, 5483.616146869681, 4865.610751139971, 4982.252662100714, 4984.077945580007, 5056.9494305057215, 5104.846854594368, 5829.358770535237, 5884.205632239678, 5914.083317085945, 5915.3788852170765, 5971.223740913741, 5735.139729040678, 5766.3080430346945, 5788.189653448605, 5804.738786754522, 5821.825345239649, 5627.0434026214825, 5715.8571035724435, 5759.222504961776, 5827.1841942127285, 5898.911516327173, 5707.229524014371, 5748.425157484218, 5800.361960184461, 5802.651840889392, 5852.18069470283, 5728.799492017926, 5789.044807606866, 5797.710114494343, 5807.332156801853, 5814.0, 5444.047291724011, 5595.8880822384135, 5596.0, 5678.034734095297, 5692.288463942007, 5515.283013208257, 5596.972015139898, 5603.943960560342, 5637.548996080386, 5643.3510146332055, 5503.834884953458, 5579.330480342385, 5588.189712491747, 5590.608657394106, 5600.243967064557, 5578.0, 5592.636478628876, 5644.943550564606, 5696.145578163143, 5697.743601537858, 5366.114591092426, 5410.107332290128, 5452.6183167177915, 5455.809046683347, 5483.396826349019], "unit": "score", "name": "dojo.html", "value": 5287.206881506557}, {"lowerIsBetter": false, "replicates": [549.9223355298069, 593.6378808926555, 605.1286147946957, 611.6666416802842, 612.3264409149933, 29883.551746723788, 30638.234044148907, 37053.258934821286, 37409.0, 37518.43722344167, 42118.57881421185, 42607.14785704284, 42616.360754588626, 42625.57374426255, 42677.35983960243, 7538.396928245727, 8724.08397118303, 8900.73297801067, 8900.753894454781, 8906.287497000225, 7715.267049630276, 10605.204609654307, 10863.45682715861, 10867.402292873889, 10868.45657717115, 10406.791864162713, 10515.316504427226, 10515.791683746422, 10517.894821051807, 10526.473676316193, 7740.806479837993, 7870.763877083697, 10420.062194402502, 10505.31715438494, 10543.683689489328, 10209.744756381077, 10317.43254121023, 10354.068133867913, 10367.844482332772, 10371.585136594527, 39616.20767584661, 39817.80091099555, 40130.0, 40134.0, 40244.39633405501, 3144.4340018796606, 3300.1089705779546, 3330.317284956602, 3358.345122701074, 3673.5959044505084, 30020.399592008256, 30375.0, 30458.238544036576, 30684.693153068405, 31232.063038108667, 3730.1607138393915, 3824.2160357127, 3825.081980324702, 3830.3871380579253, 3915.9412608810608, 405838.3285922098, 407922.0, 410394.0, 410574.0, 410966.0, 57776.71111644415, 58088.0, 58240.0, 58563.12155317674, 58587.414125858195, 61980.38019619836, 62213.377866220755, 62959.370406296264, 64039.679801600694, 65249.347506524326, 13705.246211458267, 13818.309084545732, 13937.860621393656, 13940.163590184622, 13942.721145577032, 9468.38455500404, 9505.334626576074, 9518.952405238068, 9575.09036641518, 9849.50752462374, 17769.200385982662, 20168.0, 20285.391438256876, 20692.0, 20869.269575564784, 7594.31651151399, 7864.842703145905, 7878.684852605831, 7885.014373203349, 7996.760097197093, 942.8444306689456, 973.3721749471551, 1049.6431213387484, 1061.3950048472298, 1068.1668298727006, 28099.157025289274, 28555.28611784722, 28713.425731485255, 28838.0, 28990.565141522893, 1059.7880423915249, 1067.1942683274078, 1102.8290614954535, 1104.7403860092872, 1105.264998775805, 14899.329530171168, 14983.32575034126, 15114.773278400833, 15258.0, 15356.923215383851, 320449.0, 324535.0, 325747.0, 326159.0, 326212.0, 51393.229101563506, 51647.0, 51861.48138518642, 51913.2213016805, 51938.22092668613, 1286.3568215892053, 1291.735194285188, 1293.618382577142, 1304.1523010043547, 1313.8029295605736, 27197.59203611987, 28216.85891570529, 28376.28685831824, 28499.572506412835, 28718.138455846358, 45924.770376147906, 46373.76813115913, 46456.0, 46477.3028404581, 46509.3023604653, 311446.0, 313603.0, 315341.0, 315445.0, 315499.0, 27268.323947727204, 27615.58576621312, 27997.160085197476, 28048.71951280461, 28084.157475275773, 37043.814780925924, 40805.79597101996, 41010.794946026275, 41215.587844122376, 41400.79299603483, 34050.0, 34481.0, 34614.30771384609, 35070.29859402747, 35567.28865422625, 34959.0, 35155.0, 35407.11482212862, 35492.82253588716, 35575.288494229455, 30360.0, 30676.84661576678, 30981.69018309878, 34375.484367734, 35321.293574127856, 30415.935442259415, 31515.369692606477, 31642.841785790923, 31692.366152677278, 31876.0, 24037.0, 24263.51472970566, 24415.267541973768, 24878.37804054913, 24892.37769055788], "unit": "score", "name": "ext.html", "value": 18661.99850717126}, {"lowerIsBetter": false, "replicates": [353.19647801252165, 353.98761043363487, 358.86542546545047, 360.245286125567, 362.09837504613506, 13997.860021399783, 14363.71272574548, 16152.273147708353, 16350.509484715463, 17020.659586808273, 11729.70675733107, 12291.631251062483, 13870.861291387084, 14357.0667906586, 14450.566483005527, 5278.524932756051, 5398.676079435227, 5409.5672346212405, 5427.104527752916, 5431.131019036955, 4026.0740029793164, 4126.484189476316, 5317.548008419289, 5414.160805075219, 5456.045192091388, 5865.7360418781045, 6070.5447091468095, 6089.573729838913, 6097.359777223394, 6099.847503812418, 5915.438033386843, 6027.9752442084955, 6045.063015232646, 6066.514678825683, 6075.17985072014, 5334.493223143834, 5346.599005074635, 5367.060764366221, 5367.275417818583, 5373.75818088183, 19570.412887613395, 19751.80248197514, 19944.90027549853, 20025.0, 20191.798082019286, 2173.0981642618294, 2212.966805497919, 2291.472961218929, 2313.34069790109, 2666.8266562673366, 12537.93731031339, 12861.87138128616, 12867.87132128676, 13225.801612975813, 13310.401031953488, 1826.8629852760964, 1832.4869036669754, 1835.2567210279858, 1845.2711179084322, 1856.6193930244267, 56575.0, 58223.12665310024, 58389.41610583925, 58650.0, 59177.0, 9395.718128456158, 9538.0, 9732.70801875945, 9756.658516951873, 9793.755156121011, 12701.555445559361, 12712.55506057302, 12717.872821271669, 12727.936360318325, 12766.234025958473, 6446.677666116675, 6575.638339891352, 6626.271110177877, 6634.933650663528, 7288.416926645856, 6036.396360364016, 6048.213732214784, 6095.146679464879, 6102.084687296941, 6109.114178444101, 4369.47566292047, 4401.823927042882, 4452.109578084332, 4459.130469558405, 4493.191225579427, 1576.3221814619824, 1597.672477142183, 1764.8323409276097, 1784.7412125242026, 1827.9817201828077, 921.7004473546124, 923.6443969071955, 929.5816882402946, 934.4720233068294, 1048.219076787798, 16302.83697163037, 16532.338706451606, 16940.06829624358, 17120.828791711923, 17180.0, 846.9195426434479, 915.9954200228956, 936.8688383626297, 942.6512190489562, 950.9904900951041, 8908.242799361997, 9102.317326200562, 9155.81688366229, 9213.216876565568, 9257.0, 344980.0, 388535.0, 388728.0, 396690.0, 407863.0, 61808.38191618026, 68440.6577967107, 69954.0, 71830.28169718236, 72457.0, 1188.1623455463878, 1191.9761604767857, 1194.2714943884223, 1211.666791632308, 1219.554862475208, 14826.0, 15447.768283475532, 15615.453459128876, 15673.137977410895, 15689.843101568838, 34442.48336274908, 34661.48007779936, 34785.82607086949, 35445.29109417849, 35612.821935890155, 45695.31457028081, 46077.539224607324, 46214.075718486114, 47393.52606473891, 51397.7430112862, 9356.812863742824, 9541.856872147062, 9656.27577931672, 9658.034196580285, 9662.275329350467, 11364.602238921598, 16816.495505134866, 17224.82775172232, 17533.561660958578, 17652.470425887244, 14287.64280892986, 14359.712805744035, 14418.855811441752, 14633.560993170222, 14803.92598037003, 13483.393247304091, 14036.087654302437, 14313.713725725636, 14376.209308487716, 14488.855111449173, 14066.507672231422, 14141.292935353396, 14360.35378407995, 14528.20094894791, 14937.62655933567, 9249.0, 9439.575219115019, 9484.241260699266, 9733.318667693193, 9735.318527702993, 13903.443862245396, 14082.859171408154, 14186.077904936146, 14435.061720988102, 14554.0], "unit": "score", "name": "jquery.html", "value": 8688.476806452385}, {"lowerIsBetter": false, "replicates": [1555.2923419843971, 1690.5090987111614, 1714.331410749808, 1723.2331612432465, 1762.9206685699141, 6471.223453185618, 7162.892556611649, 7539.547627142361, 7557.546547207165, 7581.962090189541, 7345.963270183655, 7469.925300746991, 7483.812904677372, 7485.925140748591, 7497.212792656775, 1888.4806678163477, 1922.8557858160625, 1925.528245579835, 2150.9139634414646, 2172.4460262633083, 2147.6778483227563, 2175.934721958336, 2176.270949232009, 2179.7384313882276, 2182.967255491169, 2099.4751312171957, 2127.0747224957195, 2220.4892874638845, 2221.0116498158327, 2222.277759728087, 2171.945701357463, 2177.8693278403266, 2205.8125059369972, 2205.911763529465, 2216.822654187661, 2213.3802535289983, 2238.317313219484, 2240.372695645222, 2241.641337386027, 2243.2036626997506, 7541.283578060075, 7576.318131368148, 7590.58251796151, 7593.9240607593765, 7609.467337286392, 4567.474740404863, 4591.449026116854, 4596.816127354902, 4598.79305431253, 4657.254839225741, 2991.790574659775, 2998.920388660081, 3042.923926901823, 3058.801177923428, 3078.9538156927665, 978.8923218445965, 990.1089019882164, 1027.4451796030135, 1043.4782608695652, 1096.7203363142428, 9966.9501652492, 9986.850197247048, 9986.950065249699, 9996.40021598699, 10010.54952527138, 4136.937945930814, 4165.937510937339, 4261.296886013773, 4272.423222864935, 4282.229198744256, 8624.913750862537, 8682.739517814476, 8683.869741953877, 8721.60752766127, 8725.650973961097, 4570.268756998864, 4606.447226332862, 4609.170349337084, 4620.237660786, 4624.190766615829, 4161.0845613964875, 4224.218519573888, 4224.4508213931995, 4225.070484493406, 4227.365895115696, 3294.9176270593425, 3336.4494858348103, 3396.4565669492763, 3448.8792892248653, 3458.066322093021, 1134.2003887259461, 1138.2771939818274, 1141.8173092305192, 1144.370596172102, 1145.4673576786834, 976.8534719792088, 980.9895807318474, 1038.8337865941412, 1039.0233180810014, 1103.1836441033577, 7182.317679820409, 7258.056452661121, 7265.673044713, 7279.818004549928, 7282.635868206568, 1025.374521541859, 1028.4908970059869, 1044.2690116918188, 1113.5100555755441, 1136.471540733563, 5668.433156684381, 5707.771689132472, 5727.083666613322, 5737.340205876294, 5750.396208398141, 8748.256398206224, 9039.81920361589, 9130.863037054449, 9224.169824715807, 9228.0, 8835.823283534293, 9010.098990100938, 9038.09619038104, 9069.954650226706, 9070.773230669287, 6746.595204287661, 6760.087388202628, 6849.965750171217, 6860.1081859358965, 7000.614966176808, 6713.12729345182, 6889.311068893271, 6923.723051077901, 6924.861502770017, 6929.341712537301, 7943.24539168778, 8000.15998320168, 8059.959700201462, 8240.01119865596, 8255.25702686737, 8157.34741220689, 8191.959040204761, 8236.629351679068, 8387.287080598218, 8421.747347579583, 6088.543359248163, 6469.223693156851, 6541.116949211795, 6589.24223714279, 6594.505412094016, 6384.0, 6459.741610335534, 6467.514936379885, 6879.484038697218, 7337.779866604011, 6854.760083397057, 6914.412274956685, 6963.373296403348, 7017.649117544001, 7028.051213086168, 6810.9318906810295, 6843.349881761224, 6851.417629501549, 6958.582485050913, 6981.127359080115, 6944.756933507303, 6954.269801670752, 6956.965215173892, 6958.095447591781, 6971.65141742921, 5968.850778730566, 6105.084237364431, 6148.3236843948025, 6345.270293916259, 6402.455791257796, 6498.805035848932, 6536.182977127859, 6538.1500404947055, 6540.117084193573, 6544.3782840630065], "unit": "score", "name": "mootools.html", "value": 4338.527372927364}, {"lowerIsBetter": false, "replicates": [338.39765217912117, 345.08208166277706, 349.2351749668228, 351.3412351840299, 355.3461630599696, 5766.192733017381, 5912.497437717789, 5931.970340148298, 5979.431953964372, 5997.37027612101, 5765.077587585987, 5846.21076154719, 5871.76512939483, 5883.441073098049, 5911.556633252512, 4581.473130589975, 4592.678512504126, 4593.839215627454, 4595.035042641032, 4596.517365676606, 4378.759168245745, 4455.264881294583, 4472.284434490482, 4557.726536407826, 4595.195840727859, 4518.864434066967, 4528.071745292207, 4528.479224889131, 4546.272596384579, 4552.385427967231, 4538.251188553884, 4541.818327266906, 4551.021530370953, 4559.042601053783, 4561.0, 4002.459667944819, 4012.1173341865033, 4016.3373043447796, 4025.5910431349084, 4032.2741906456827, 5573.749181286852, 5671.858203544944, 5683.602147849652, 5717.942820571782, 5718.5711071669375, 5273.683578985235, 5274.472552744734, 5278.9208161877605, 5279.340082489689, 5284.0, 6079.908801367983, 6346.0798184263485, 6346.682665866688, 6348.714307856158, 6358.586691865014, 4280.336547835091, 4297.39836422901, 4390.100029493978, 4391.758453285068, 4401.779911004437, 6517.804465866032, 6521.739130434777, 6553.082568440422, 6563.310852360529, 6601.0, 4467.15124126415, 4473.709208901411, 4475.239209334421, 4482.036362182146, 4494.77526123699, 4442.53353397895, 4507.3689683444345, 4538.04701012791, 4540.750258735801, 4559.521250268674, 5221.530062294411, 5246.265522826808, 5251.36983561975, 5255.658382205144, 5269.446708095671, 6308.274548426898, 6311.810645680545, 6358.554901156875, 6362.268339141058, 6386.361363863576, 1584.8494393032643, 1602.9679406411806, 1603.8556529912364, 1604.3903316739563, 1606.5421354913794, 1042.593388578455, 1044.9268551201494, 1064.3347907557777, 1065.9520321585546, 1074.140687450037, 6116.418940200674, 6131.172291740647, 6144.662043587557, 6145.600535965148, 6149.723262453201, 6565.967170164118, 6567.408933196035, 6572.07990881277, 6574.243961944438, 6580.21037475506, 5998.640081595118, 6049.485793707584, 6079.966405711039, 6128.969355153285, 6136.048912418582, 3534.204803919149, 3550.3609350316674, 3554.040409089583, 3575.1955809943074, 3582.408902531053, 6590.275069742324, 6603.70283337251, 6633.502487313471, 6644.368784965421, 6660.70026848793, 6565.0, 6680.465562754968, 6709.094272273278, 6710.094137291403, 6710.798676039727, 6581.83545411359, 6636.900446493307, 6645.767398141042, 6647.468202543785, 6670.733170673118, 6355.650439225887, 6473.514486413632, 6498.545101842826, 6560.868782624416, 6563.901541476786, 6399.200099987502, 6543.803685889431, 6551.050097735706, 6571.605703657796, 6583.736650533925, 6727.629980351127, 6727.663616819237, 6733.595984240961, 6733.898991515033, 6735.766831920803, 4344.761038142932, 4430.933535997027, 4432.180046691373, 4438.335624140947, 4440.444944381952, 6611.636360000054, 6614.735410583523, 6624.238212605419, 6626.072349870926, 6628.0, 6440.9033864493, 6443.581167224115, 6448.742050317935, 6448.806535803933, 6456.418922297016, 6293.150424692608, 6362.713677884413, 6422.42198202164, 6428.035794630656, 6434.356564343529, 6312.400321969406, 6313.747450101944, 6319.273283572448, 6320.209973753281, 6324.146240257506, 6461.838454038499, 6462.644554549545, 6471.417572418317, 6478.6760661967655, 6481.740730370732, 6202.751889924352, 6305.716242768995, 6313.589616674902, 6317.6209427434505, 6328.398802113792], "unit": "score", "name": "prototype.html", "value": 4779.712582460391}, {"lowerIsBetter": false, "replicates": [765.2347652347653, 835.2900034970276, 847.665172256959, 860.6385318166369, 867.2151702709047, 13330.800037999426, 13656.453741850326, 13703.38334774935, 13725.93137034316, 13773.724525509497, 12866.742665146692, 12975.286359250238, 12977.221366718004, 12989.285589292585, 12993.155444896076, 680.2958937499689, 686.8557602903396, 811.4117264982899, 818.2145140664969, 835.0480452284401, 828.2090603473698, 829.5147338806775, 830.4726498673325, 835.7116794705847, 836.2849763452252, 851.9659213631447, 857.695518091075, 860.3074525007366, 861.8879545659056, 863.3567991846083, 694.2536772969053, 695.1067877777058, 836.8075342671159, 859.497194141428, 862.8015556421996, 635.3551145587232, 635.517007074622, 635.9682015899186, 637.4740838808002, 640.3596403596404, 13206.207627542282, 13213.471461141542, 13227.537036203783, 13242.735145297136, 13261.0, 12079.214851034654, 12082.0, 12435.689107772288, 12462.12765106443, 12548.372581370895, 10143.543540540619, 10193.541290641864, 10418.739531511697, 10427.791444171075, 10464.843027354596, 3463.9134021649406, 3515.8837268367524, 3547.9822600886832, 3561.056320075182, 3591.892243232707, 43298.78350608258, 43734.781326093485, 43767.99999999968, 44092.0, 44432.0, 8880.644774209088, 8917.643294268157, 9101.863472047924, 9104.317176211678, 9187.897452305633, 17269.56826079358, 17375.218115184845, 17432.5641858952, 17444.389446369318, 17511.38710145139, 7323.231060738653, 7409.777706668809, 7420.5547667140145, 7523.699052037857, 7815.57014364204, 3904.2386734587053, 3970.900727481778, 4033.899152521152, 4093.3041382964966, 4103.707332190351, 3021.9093427197217, 3045.9390812183633, 3068.923276918095, 3071.953920691147, 3080.661127276043, 499.4880247746017, 503.8564009257344, 510.04621358060666, 511.97952081916304, 522.9843104706865, 552.8203333916413, 624.1636207481905, 631.3395769127258, 654.1496055128314, 708.5323686366974, 8061.234182752629, 8162.347012239006, 8402.789930251793, 8505.0, 8686.913130868737, 665.2582370656779, 682.6211452643731, 682.6962001909202, 688.4251649872413, 698.4866123399297, 3949.8025098744947, 4028.71798974069, 4059.3505039193587, 4103.076807718299, 4106.240345536085, 54361.0, 55147.38231412176, 55414.72292638592, 55546.0, 55551.0, 48636.0, 49550.50449495531, 53047.73476132672, 53871.73064134654, 55018.17472737912, 44912.326315105296, 45258.32112518381, 45312.546874531494, 45388.3191752124, 45673.0, 8730.56347182651, 8825.205731484197, 8965.282777377664, 8979.730608081769, 8982.595783189903, 34988.650113499556, 35679.464808027384, 35682.82158589294, 35739.0, 35752.64247357597, 44863.775681121384, 45015.324770127816, 45112.0, 45702.0, 46034.30948535842, 10535.051845333957, 10902.454877256265, 10914.290571112851, 11049.226554141133, 11236.494357753758, 12260.448279827251, 12351.0, 12456.937715311728, 12542.874571254171, 12601.558945436866, 11467.713307167387, 11784.116191285517, 12003.819942700691, 12120.939395302967, 12212.08409369283, 11164.218504704593, 11292.943535282271, 11719.238249513754, 11732.237404568676, 11861.05111591088, 10601.840972385266, 10715.303505272132, 10833.620823271147, 11387.772244555228, 11489.0, 10023.498825058863, 10174.13519850821, 10226.148480518219, 10350.482475876326, 10405.583776649151, 9492.477913714813, 9789.0, 9860.16188623975, 9946.154576861049, 9993.400395976265], "unit": "score", "name": "yui.html", "value": 6250.667524869539}], "name": "dromaeo_css", "value": 6933.828699054123}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 112.0, 111.0, 113.0, 99.0, 110.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 147.0, 181.0, 126.0, 148.0, 149.0, 124.0, 162.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 161.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 84.0, 94.0, 76.0, 73.0, 71.0, 129.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 138.0, 93.0, 94.0, 93.0, 138.0, 95.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 145.0, 146.0, 145.0, 144.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 57.0, 58.0, 59.0, 61.0, 67.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 70.0, 73.0, 68.0, 68.0, 74.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 85.0, 85.0, 84.0, 86.0, 85.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [123.0, 121.0, 122.0, 115.0, 115.0, 116.0, 118.0, 124.0, 122.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [154.0, 157.0, 152.0, 151.0, 149.0, 155.0, 151.0, 152.0, 143.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 70.0, 69.0, 67.0, 70.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1508.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.31658125309968], "unit": "score", "name": "Richards", "value": 213.54179800000009}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1958.9041095890411], "unit": "score", "name": "RayTrace", "value": 377.7566223776223}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [640.2048655569782], "unit": "score", "name": "Splay", "value": 127.28894200000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19774.56828130749}]} 14:08:48 INFO - RETURN: dromaeo_css: 6933.83 14:08:48 INFO - RETURN: kraken: 1508.40 14:08:48 INFO - RETURN: v8_7: 19774.57 14:08:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19774.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6933.83"}}} 14:08:48 INFO - Return code: 0 14:08:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:08:48 INFO - # TBPL SUCCESS # 14:08:48 INFO - Running post-action listener: _resource_record_post_action 14:08:48 INFO - Running post-run listener: _resource_record_post_run 14:08:49 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439717888; Read time: 4; Write time: 468488 14:08:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110542848; Read time: 0; Write time: 157140 14:08:49 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320659456; Read time: 4; Write time: 297648 14:08:49 INFO - Running post-run listener: _upload_blobber_files 14:08:49 INFO - Blob upload gear active. 14:08:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:08:49 INFO - Copying logs to upload dir... 14:08:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.841231 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 14:08:48.846499) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 14:08:48.849726) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009987 build_url: 'https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 14:08:48.900992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 14:08:48.901312) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450385340.253339-926996999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 14:08:48.951295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 14:08:48.951622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 14:08:48.951902) ========= ========= Total master_lag: 0.24 =========