builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1450323882.12 results: success (0) buildid: 20151216173017 builduid: 6c8aa2c12a4a4e9fb83fe453fdb3766b revision: a8f8ec75a2a9b81aa3963ff6c330133adbd095d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.121759) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.122227) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.122592) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006254 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.148149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.148455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.163417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.163719) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.212889) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.213248) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.213647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.214021) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 19:44:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 209M=0s 2015-12-16 19:44:42 (209 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.369959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.370322) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.419835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:42.420233) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a8f8ec75a2a9b81aa3963ff6c330133adbd095d5 --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 a8f8ec75a2a9b81aa3963ff6c330133adbd095d5 --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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 19:44:42,682 truncating revision to first 12 chars 2015-12-16 19:44:42,682 Setting DEBUG logging. 2015-12-16 19:44:42,682 attempt 1/10 2015-12-16 19:44:42,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a8f8ec75a2a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 19:44:42,980 unpacking tar archive at: fx-team-a8f8ec75a2a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:43.044626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:43.044904) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:43.056692) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:43.056939) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 19:44:43.057360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2015-12-16 19:44:43.057640) ========= /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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:44:43 INFO - MultiFileLogger online at 20151216 19:44:43 in /builds/slave/test-pgo 19:44:43 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 19:44:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:44:43 INFO - {'append_to_log': False, 19:44:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:44:43 INFO - 'blob_upload_branch': 'Fx-Team', 19:44:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:44:43 INFO - 'branch': 'Fx-Team', 19:44:43 INFO - 'buildbot_json_path': 'buildprops.json', 19:44:43 INFO - 'config_files': ('talos/linux_config.py',), 19:44:43 INFO - 'default_actions': ('clobber', 19:44:43 INFO - 'read-buildbot-config', 19:44:43 INFO - 'download-and-extract', 19:44:43 INFO - 'populate-webroot', 19:44:43 INFO - 'create-virtualenv', 19:44:43 INFO - 'install', 19:44:43 INFO - 'run-tests'), 19:44:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:44:43 INFO - 'download_minidump_stackwalk': True, 19:44:43 INFO - 'download_symbols': 'ondemand', 19:44:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:44:43 INFO - 'tooltool.py': '/tools/tooltool.py', 19:44:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:44:43 INFO - '/tools/misc-python/virtualenv.py')}, 19:44:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:44:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:44:43 INFO - 'installer_path': 'installer.exe', 19:44:43 INFO - 'log_level': 'info', 19:44:43 INFO - 'log_name': 'talos', 19:44:43 INFO - 'log_to_console': True, 19:44:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:44:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:44:43 INFO - 'opt_config_files': (), 19:44:43 INFO - 'pip_index': False, 19:44:43 INFO - 'sps_profile': False, 19:44:43 INFO - 'sps_profile_interval': 0, 19:44:43 INFO - 'suite': 'dromaeojs', 19:44:43 INFO - 'system_bits': '64', 19:44:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:44:43 INFO - 'title': 'talos-linux64-ix-029', 19:44:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:44:43 INFO - 'use_talos_json': True, 19:44:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:44:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:44:43 INFO - 'work_dir': 'build'} 19:44:43 INFO - ##### 19:44:43 INFO - ##### Running clobber step. 19:44:43 INFO - ##### 19:44:43 INFO - Running pre-action listener: _resource_record_pre_action 19:44:43 INFO - Running main action method: clobber 19:44:43 INFO - rmtree: /builds/slave/test-pgo/build 19:44:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:44:43 INFO - Running post-action listener: _resource_record_post_action 19:44:43 INFO - ##### 19:44:43 INFO - ##### Running read-buildbot-config step. 19:44:43 INFO - ##### 19:44:43 INFO - Running pre-action listener: _resource_record_pre_action 19:44:43 INFO - Running main action method: read_buildbot_config 19:44:43 INFO - Using buildbot properties: 19:44:43 INFO - { 19:44:43 INFO - "project": "", 19:44:43 INFO - "product": "firefox", 19:44:43 INFO - "script_repo_revision": "production", 19:44:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:44:43 INFO - "repository": "", 19:44:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:44:43 INFO - "buildid": "20151216173017", 19:44:43 INFO - "pgo_build": "True", 19:44:43 INFO - "basedir": "/builds/slave/test-pgo", 19:44:43 INFO - "buildnumber": 839, 19:44:43 INFO - "slavename": "talos-linux64-ix-029", 19:44:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:44:43 INFO - "platform": "ubuntu64_hw", 19:44:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:44:43 INFO - "branch": "fx-team", 19:44:43 INFO - "repo_path": "integration/fx-team", 19:44:43 INFO - "revision": "a8f8ec75a2a9b81aa3963ff6c330133adbd095d5", 19:44:43 INFO - "stage_platform": "linux64-pgo", 19:44:43 INFO - "builduid": "6c8aa2c12a4a4e9fb83fe453fdb3766b", 19:44:43 INFO - "slavebuilddir": "test" 19:44:43 INFO - } 19:44:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:44:43 INFO - Running post-action listener: _resource_record_post_action 19:44:43 INFO - ##### 19:44:43 INFO - ##### Running download-and-extract step. 19:44:43 INFO - ##### 19:44:43 INFO - Running pre-action listener: _resource_record_pre_action 19:44:43 INFO - Running main action method: download_and_extract 19:44:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:43 INFO - https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/test_packages.json 19:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/test_packages.json 19:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:44:48 INFO - Downloaded 1302 bytes. 19:44:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:44:48 INFO - Using the following test package requirements: 19:44:48 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:48 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:44:48 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:48 INFO - u'jsshell-linux-x86_64.zip'], 19:44:48 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:44:48 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:48 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:44:48 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:44:48 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:44:48 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:48 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:44:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:48 INFO - https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:50 INFO - Downloaded 23118060 bytes. 19:44:50 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 19:44:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:50 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 19:44:51 INFO - Return code: 0 19:44:51 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 19:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:51 INFO - https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:55 INFO - Downloaded 23118060 bytes. 19:44:55 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 19:44:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:44:55 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 19:44:56 INFO - Return code: 0 19:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:56 INFO - https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:44:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:57 INFO - Downloaded 11132052 bytes. 19:44:57 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 19:44:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:57 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 19:44:58 INFO - Return code: 0 19:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:58 INFO - https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:44:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dcBldwPyTMKLVrza36ZxRw/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 19:44:59 INFO - Downloaded 59285384 bytes. 19:44:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:59 INFO - mkdir: /builds/slave/test-pgo/properties 19:44:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:44:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:44:59 INFO - Contents: 19:44:59 INFO - build_url:https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:44:59 INFO - Running post-action listener: _resource_record_post_action 19:44:59 INFO - Running post-action listener: set_extra_try_arguments 19:44:59 INFO - ##### 19:44:59 INFO - ##### Running populate-webroot step. 19:44:59 INFO - ##### 19:44:59 INFO - Running pre-action listener: _resource_record_pre_action 19:44:59 INFO - Running main action method: populate_webroot 19:44:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:44:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:44:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:44:59 INFO - '--tppagecycles', 19:44:59 INFO - '7'], 19:44:59 INFO - 'tests': ['tsvgm']}}, 19:44:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:44:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:44:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'tests': ['damp', 'tps']}, 19:44:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['damp', 'tps']}, 19:44:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:44:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:44:59 INFO - 'other': {'tests': ['a11yr', 19:44:59 INFO - 'ts_paint', 19:44:59 INFO - 'tpaint', 19:44:59 INFO - 'sessionrestore', 19:44:59 INFO - 'sessionrestore_no_auto_restore']}, 19:44:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['a11yr', 19:44:59 INFO - 'ts_paint', 19:44:59 INFO - 'tpaint', 19:44:59 INFO - 'sessionrestore', 19:44:59 INFO - 'sessionrestore_no_auto_restore']}, 19:44:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['a11yr', 19:44:59 INFO - 'ts_paint', 19:44:59 INFO - 'tpaint', 19:44:59 INFO - 'sessionrestore', 19:44:59 INFO - 'sessionrestore_no_auto_restore']}, 19:44:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['a11yr', 19:44:59 INFO - 'ts_paint', 19:44:59 INFO - 'tpaint', 19:44:59 INFO - 'sessionrestore', 19:44:59 INFO - 'sessionrestore_no_auto_restore']}, 19:44:59 INFO - 'other_l64': {'tests': ['a11yr', 19:44:59 INFO - 'ts_paint', 19:44:59 INFO - 'tpaint', 19:44:59 INFO - 'sessionrestore', 19:44:59 INFO - 'sessionrestore_no_auto_restore']}, 19:44:59 INFO - 'other_nol64': {'tests': ['a11yr', 19:44:59 INFO - 'ts_paint', 19:44:59 INFO - 'tpaint', 19:44:59 INFO - 'sessionrestore', 19:44:59 INFO - 'sessionrestore_no_auto_restore']}, 19:44:59 INFO - 'svgr': {'tests': ['tsvgx', 19:44:59 INFO - 'tsvgr_opacity', 19:44:59 INFO - 'tart', 19:44:59 INFO - 'tscrollx', 19:44:59 INFO - 'cart']}, 19:44:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['tsvgx', 19:44:59 INFO - 'tsvgr_opacity', 19:44:59 INFO - 'tart', 19:44:59 INFO - 'tscrollx', 19:44:59 INFO - 'cart']}, 19:44:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'tests': ['tp5o']}, 19:44:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'talos_options': ['--e10s'], 19:44:59 INFO - 'tests': ['tp5o']}, 19:44:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'talos_options': ['--xperf_path', 19:44:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:59 INFO - 'tests': ['tp5n']}, 19:44:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:59 INFO - 'talos_options': ['--e10s', 19:44:59 INFO - '--xperf_path', 19:44:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:59 INFO - 'tests': ['tp5n']}}, 19:44:59 INFO - 'talos.zip': {'path': '', 19:44:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:44:59 INFO - Running post-action listener: _resource_record_post_action 19:44:59 INFO - ##### 19:44:59 INFO - ##### Running create-virtualenv step. 19:44:59 INFO - ##### 19:44:59 INFO - Running pre-action listener: _resource_record_pre_action 19:44:59 INFO - Running main action method: create_virtualenv 19:44:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:44:59 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 19:44:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:44:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:44:59 INFO - Using real prefix '/usr' 19:44:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:45:00 INFO - Installing distribute.............................................................................................................................................................................................done. 19:45:02 INFO - Installing pip.................done. 19:45:02 INFO - Return code: 0 19:45:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:02 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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:02 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 19:45:02 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 19:45:02 INFO - Using env: {'DISPLAY': ':0', 19:45:02 INFO - 'HOME': '/home/cltbld', 19:45:02 INFO - 'LANG': 'en_US.UTF-8', 19:45:02 INFO - 'LANGUAGE': 'en_US:en', 19:45:02 INFO - 'LOGNAME': 'cltbld', 19:45:02 INFO - 'MAIL': '/var/mail/cltbld', 19:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:02 INFO - 'MOZ_NO_REMOTE': '1', 19:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:02 INFO - 'NO_EM_RESTART': '1', 19:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:02 INFO - 'SHELL': '/bin/bash', 19:45:02 INFO - 'SHLVL': '1', 19:45:02 INFO - 'TERM': 'linux', 19:45:02 INFO - 'TMOUT': '86400', 19:45:02 INFO - 'USER': 'cltbld', 19:45:02 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:02 INFO - '_': '/tools/buildbot/bin/python'} 19:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:02 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 19:45:02 INFO - Cleaning up... 19:45:02 INFO - Return code: 0 19:45:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:02 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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:02 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 19:45:02 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 19:45:02 INFO - Using env: {'DISPLAY': ':0', 19:45:02 INFO - 'HOME': '/home/cltbld', 19:45:02 INFO - 'LANG': 'en_US.UTF-8', 19:45:02 INFO - 'LANGUAGE': 'en_US:en', 19:45:02 INFO - 'LOGNAME': 'cltbld', 19:45:02 INFO - 'MAIL': '/var/mail/cltbld', 19:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:02 INFO - 'MOZ_NO_REMOTE': '1', 19:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:02 INFO - 'NO_EM_RESTART': '1', 19:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:02 INFO - 'SHELL': '/bin/bash', 19:45:02 INFO - 'SHLVL': '1', 19:45:02 INFO - 'TERM': 'linux', 19:45:02 INFO - 'TMOUT': '86400', 19:45:02 INFO - 'USER': 'cltbld', 19:45:02 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:02 INFO - '_': '/tools/buildbot/bin/python'} 19:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:02 INFO - Downloading/unpacking psutil>=0.7.1 19:45:02 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 19:45:02 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 19:45:02 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 19:45:02 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 19:45:02 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 19:45:02 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 19:45:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:45:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:45:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:45:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:04 INFO - Installing collected packages: psutil 19:45:04 INFO - Running setup.py install for psutil 19:45:04 INFO - building 'psutil._psutil_linux' extension 19:45:04 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 19:45:04 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 19:45:04 INFO - building 'psutil._psutil_posix' extension 19:45:04 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 19:45:04 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 19:45:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:04 INFO - Successfully installed psutil 19:45:04 INFO - Cleaning up... 19:45:04 INFO - Return code: 0 19:45:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:04 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 19:45:04 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 19:45:04 INFO - Using env: {'DISPLAY': ':0', 19:45:04 INFO - 'HOME': '/home/cltbld', 19:45:04 INFO - 'LANG': 'en_US.UTF-8', 19:45:04 INFO - 'LANGUAGE': 'en_US:en', 19:45:04 INFO - 'LOGNAME': 'cltbld', 19:45:04 INFO - 'MAIL': '/var/mail/cltbld', 19:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:04 INFO - 'MOZ_NO_REMOTE': '1', 19:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:04 INFO - 'NO_EM_RESTART': '1', 19:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:04 INFO - 'SHELL': '/bin/bash', 19:45:04 INFO - 'SHLVL': '1', 19:45:04 INFO - 'TERM': 'linux', 19:45:04 INFO - 'TMOUT': '86400', 19:45:04 INFO - 'USER': 'cltbld', 19:45:04 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:04 INFO - '_': '/tools/buildbot/bin/python'} 19:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:45:06 INFO - Installing collected packages: mozsystemmonitor 19:45:06 INFO - Running setup.py install for mozsystemmonitor 19:45:06 INFO - Successfully installed mozsystemmonitor 19:45:06 INFO - Cleaning up... 19:45:06 INFO - Return code: 0 19:45:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:45:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:45:06 INFO - Using env: {'DISPLAY': ':0', 19:45:06 INFO - 'HOME': '/home/cltbld', 19:45:06 INFO - 'LANG': 'en_US.UTF-8', 19:45:06 INFO - 'LANGUAGE': 'en_US:en', 19:45:06 INFO - 'LOGNAME': 'cltbld', 19:45:06 INFO - 'MAIL': '/var/mail/cltbld', 19:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:06 INFO - 'MOZ_NO_REMOTE': '1', 19:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:06 INFO - 'NO_EM_RESTART': '1', 19:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:06 INFO - 'SHELL': '/bin/bash', 19:45:06 INFO - 'SHLVL': '1', 19:45:06 INFO - 'TERM': 'linux', 19:45:06 INFO - 'TMOUT': '86400', 19:45:06 INFO - 'USER': 'cltbld', 19:45:06 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:06 INFO - '_': '/tools/buildbot/bin/python'} 19:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:07 INFO - Downloading/unpacking blobuploader==1.2.4 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:45:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:45:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:45:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:45:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:45:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45:09 INFO - Downloading docopt-0.6.1.tar.gz 19:45:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:45:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:45:09 INFO - Installing collected packages: blobuploader, requests, docopt 19:45:09 INFO - Running setup.py install for blobuploader 19:45:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:45:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:45:09 INFO - Running setup.py install for requests 19:45:10 INFO - Running setup.py install for docopt 19:45:10 INFO - Successfully installed blobuploader requests docopt 19:45:10 INFO - Cleaning up... 19:45:10 INFO - Return code: 0 19:45:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:10 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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:10 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 19:45:10 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 19:45:10 INFO - Using env: {'DISPLAY': ':0', 19:45:10 INFO - 'HOME': '/home/cltbld', 19:45:10 INFO - 'LANG': 'en_US.UTF-8', 19:45:10 INFO - 'LANGUAGE': 'en_US:en', 19:45:10 INFO - 'LOGNAME': 'cltbld', 19:45:10 INFO - 'MAIL': '/var/mail/cltbld', 19:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:10 INFO - 'MOZ_NO_REMOTE': '1', 19:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:10 INFO - 'NO_EM_RESTART': '1', 19:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:10 INFO - 'SHELL': '/bin/bash', 19:45:10 INFO - 'SHLVL': '1', 19:45:10 INFO - 'TERM': 'linux', 19:45:10 INFO - 'TMOUT': '86400', 19:45:10 INFO - 'USER': 'cltbld', 19:45:10 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:10 INFO - '_': '/tools/buildbot/bin/python'} 19:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:10 INFO - Running setup.py (path:/tmp/pip-tYA3qZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:10 INFO - Running setup.py (path:/tmp/pip-B5aole-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:10 INFO - Running setup.py (path:/tmp/pip-fs_av0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:10 INFO - Running setup.py (path:/tmp/pip-xFyVjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:10 INFO - Running setup.py (path:/tmp/pip-SgDkwy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:10 INFO - Running setup.py (path:/tmp/pip-Ey54oN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:10 INFO - Running setup.py (path:/tmp/pip-jJHMlA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:10 INFO - Running setup.py (path:/tmp/pip-oMHuYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:11 INFO - Running setup.py (path:/tmp/pip-9hY7Pl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:11 INFO - Running setup.py (path:/tmp/pip-LOyNS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:11 INFO - Running setup.py (path:/tmp/pip-n9qiDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:11 INFO - Running setup.py (path:/tmp/pip-s5MIj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:11 INFO - Running setup.py (path:/tmp/pip-CpewQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:11 INFO - Running setup.py (path:/tmp/pip-FDjJ97-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:11 INFO - Running setup.py (path:/tmp/pip-dgebbX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:11 INFO - Running setup.py (path:/tmp/pip-xidncA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:11 INFO - Running setup.py (path:/tmp/pip-g5pMUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:45:11 INFO - Running setup.py install for manifestparser 19:45:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:45:11 INFO - Running setup.py install for mozcrash 19:45:11 INFO - Running setup.py install for mozdebug 19:45:11 INFO - Running setup.py install for mozdevice 19:45:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Running setup.py install for mozfile 19:45:12 INFO - Running setup.py install for mozhttpd 19:45:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Running setup.py install for mozinfo 19:45:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Running setup.py install for mozInstall 19:45:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Running setup.py install for mozleak 19:45:12 INFO - Running setup.py install for mozlog 19:45:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Running setup.py install for moznetwork 19:45:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Running setup.py install for mozprocess 19:45:12 INFO - Running setup.py install for mozprofile 19:45:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:45:12 INFO - Running setup.py install for mozrunner 19:45:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:45:13 INFO - Running setup.py install for mozscreenshot 19:45:13 INFO - Running setup.py install for moztest 19:45:13 INFO - Running setup.py install for mozversion 19:45:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:45:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:45:13 INFO - Cleaning up... 19:45:13 INFO - Return code: 0 19:45:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:13 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')]} 19:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:13 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')]} 19:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:13 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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:13 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 19:45:13 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 19:45:13 INFO - Using env: {'DISPLAY': ':0', 19:45:13 INFO - 'HOME': '/home/cltbld', 19:45:13 INFO - 'LANG': 'en_US.UTF-8', 19:45:13 INFO - 'LANGUAGE': 'en_US:en', 19:45:13 INFO - 'LOGNAME': 'cltbld', 19:45:13 INFO - 'MAIL': '/var/mail/cltbld', 19:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:13 INFO - 'MOZ_NO_REMOTE': '1', 19:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:13 INFO - 'NO_EM_RESTART': '1', 19:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:13 INFO - 'SHELL': '/bin/bash', 19:45:13 INFO - 'SHLVL': '1', 19:45:13 INFO - 'TERM': 'linux', 19:45:13 INFO - 'TMOUT': '86400', 19:45:13 INFO - 'USER': 'cltbld', 19:45:13 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:13 INFO - '_': '/tools/buildbot/bin/python'} 19:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:13 INFO - Running setup.py (path:/tmp/pip-n1PTwZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:13 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)) 19:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:13 INFO - Running setup.py (path:/tmp/pip-DDifrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:13 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)) 19:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:13 INFO - Running setup.py (path:/tmp/pip-Dx0nRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:13 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)) 19:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:13 INFO - Running setup.py (path:/tmp/pip-fSF18d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:13 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)) 19:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:13 INFO - Running setup.py (path:/tmp/pip-013YBY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:13 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)) 19:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:13 INFO - Running setup.py (path:/tmp/pip-9UuwvH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:14 INFO - Running setup.py (path:/tmp/pip-hdwT8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:14 INFO - Running setup.py (path:/tmp/pip-Rek4ns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:14 INFO - Running setup.py (path:/tmp/pip-6cEZAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:14 INFO - Running setup.py (path:/tmp/pip-CRiWXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:14 INFO - Running setup.py (path:/tmp/pip-A8EqcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:14 INFO - Running setup.py (path:/tmp/pip-K7xYX2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:14 INFO - Running setup.py (path:/tmp/pip-2jqANT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:14 INFO - Running setup.py (path:/tmp/pip-CmcTNC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:14 INFO - Running setup.py (path:/tmp/pip-Sr1Xgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:14 INFO - Running setup.py (path:/tmp/pip-Ohp36Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:14 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)) 19:45:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:14 INFO - Running setup.py (path:/tmp/pip-06Qgwt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:14 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)) 19:45:14 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)) 19:45:14 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)) 19:45:14 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)) 19:45:14 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)) 19:45:14 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)) 19:45:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45:16 INFO - Downloading blessings-1.5.1.tar.gz 19:45:16 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 19:45:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:45:16 INFO - Installing collected packages: blessings 19:45:16 INFO - Running setup.py install for blessings 19:45:16 INFO - Successfully installed blessings 19:45:16 INFO - Cleaning up... 19:45:16 INFO - Return code: 0 19:45:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:45:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:45:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:45:16 INFO - Reading from file tmpfile_stdout 19:45:16 INFO - Current package versions: 19:45:16 INFO - argparse == 1.2.1 19:45:16 INFO - blessings == 1.5.1 19:45:16 INFO - blobuploader == 1.2.4 19:45:16 INFO - docopt == 0.6.1 19:45:16 INFO - manifestparser == 1.1 19:45:16 INFO - mozInstall == 1.12 19:45:16 INFO - mozcrash == 0.16 19:45:16 INFO - mozdebug == 0.1 19:45:16 INFO - mozdevice == 0.47 19:45:16 INFO - mozfile == 1.2 19:45:16 INFO - mozhttpd == 0.7 19:45:16 INFO - mozinfo == 0.9 19:45:16 INFO - mozleak == 0.1 19:45:16 INFO - mozlog == 3.1 19:45:16 INFO - moznetwork == 0.27 19:45:16 INFO - mozprocess == 0.22 19:45:16 INFO - mozprofile == 0.27 19:45:16 INFO - mozrunner == 6.11 19:45:16 INFO - mozscreenshot == 0.1 19:45:16 INFO - mozsystemmonitor == 0.0 19:45:16 INFO - moztest == 0.7 19:45:16 INFO - mozversion == 1.4 19:45:16 INFO - psutil == 3.1.1 19:45:16 INFO - requests == 1.2.3 19:45:16 INFO - wsgiref == 0.1.2 19:45:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:16 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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:16 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 19:45:16 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 19:45:16 INFO - Using env: {'DISPLAY': ':0', 19:45:16 INFO - 'HOME': '/home/cltbld', 19:45:16 INFO - 'LANG': 'en_US.UTF-8', 19:45:16 INFO - 'LANGUAGE': 'en_US:en', 19:45:16 INFO - 'LOGNAME': 'cltbld', 19:45:16 INFO - 'MAIL': '/var/mail/cltbld', 19:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:16 INFO - 'MOZ_NO_REMOTE': '1', 19:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:16 INFO - 'NO_EM_RESTART': '1', 19:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:16 INFO - 'SHELL': '/bin/bash', 19:45:16 INFO - 'SHLVL': '1', 19:45:16 INFO - 'TERM': 'linux', 19:45:16 INFO - 'TMOUT': '86400', 19:45:16 INFO - 'USER': 'cltbld', 19:45:16 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:16 INFO - '_': '/tools/buildbot/bin/python'} 19:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 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)) 19:45:17 INFO - Cleaning up... 19:45:17 INFO - Return code: 0 19:45:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:17 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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:17 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 19:45:17 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 19:45:17 INFO - Using env: {'DISPLAY': ':0', 19:45:17 INFO - 'HOME': '/home/cltbld', 19:45:17 INFO - 'LANG': 'en_US.UTF-8', 19:45:17 INFO - 'LANGUAGE': 'en_US:en', 19:45:17 INFO - 'LOGNAME': 'cltbld', 19:45:17 INFO - 'MAIL': '/var/mail/cltbld', 19:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:17 INFO - 'MOZ_NO_REMOTE': '1', 19:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:17 INFO - 'NO_EM_RESTART': '1', 19:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:17 INFO - 'SHELL': '/bin/bash', 19:45:17 INFO - 'SHLVL': '1', 19:45:17 INFO - 'TERM': 'linux', 19:45:17 INFO - 'TMOUT': '86400', 19:45:17 INFO - 'USER': 'cltbld', 19:45:17 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:17 INFO - '_': '/tools/buildbot/bin/python'} 19:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:17 INFO - Downloading/unpacking jsonschema 19:45:17 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 19:45:17 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 19:45:17 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 19:45:17 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 19:45:17 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 19:45:17 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 19:45:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:45:19 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 19:45:19 INFO - Downloading/unpacking functools32 (from jsonschema) 19:45:19 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 19:45:19 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 19:45:19 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 19:45:19 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 19:45:19 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 19:45:19 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 19:45:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:45:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:45:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:45:19 INFO - warning: no files found matching '*.txt' 19:45:19 INFO - no previously-included directories found matching 'build' 19:45:19 INFO - no previously-included directories found matching 'dist' 19:45:19 INFO - no previously-included directories found matching '.git*' 19:45:19 INFO - Installing collected packages: jsonschema, functools32 19:45:19 INFO - Running setup.py install for functools32 19:45:19 INFO - warning: no files found matching '*.txt' 19:45:19 INFO - no previously-included directories found matching 'build' 19:45:19 INFO - no previously-included directories found matching 'dist' 19:45:19 INFO - no previously-included directories found matching '.git*' 19:45:19 INFO - Successfully installed jsonschema functools32 19:45:19 INFO - Cleaning up... 19:45:19 INFO - Return code: 0 19:45:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:19 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 0x7fb2e0ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, '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': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', '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 19:45:19 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 19:45:19 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 19:45:19 INFO - Using env: {'DISPLAY': ':0', 19:45:19 INFO - 'HOME': '/home/cltbld', 19:45:19 INFO - 'LANG': 'en_US.UTF-8', 19:45:19 INFO - 'LANGUAGE': 'en_US:en', 19:45:19 INFO - 'LOGNAME': 'cltbld', 19:45:19 INFO - 'MAIL': '/var/mail/cltbld', 19:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:19 INFO - 'MOZ_NO_REMOTE': '1', 19:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:19 INFO - 'NO_EM_RESTART': '1', 19:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:19 INFO - 'SHELL': '/bin/bash', 19:45:19 INFO - 'SHLVL': '1', 19:45:19 INFO - 'TERM': 'linux', 19:45:19 INFO - 'TMOUT': '86400', 19:45:19 INFO - 'USER': 'cltbld', 19:45:19 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:19 INFO - '_': '/tools/buildbot/bin/python'} 19:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:19 INFO - Downloading/unpacking flake8 19:45:19 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 19:45:19 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 19:45:19 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 19:45:19 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 19:45:19 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 19:45:19 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 19:45:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:45:21 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 19:45:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:45:21 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 19:45:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:45:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:45:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:22 INFO - no previously-included directories found matching 'docs/_build' 19:45:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:45:22 INFO - Running setup.py install for pep8 19:45:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:22 INFO - no previously-included directories found matching 'docs/_build' 19:45:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:45:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:45:22 INFO - Cleaning up... 19:45:22 INFO - Return code: 0 19:45:22 INFO - Running post-action listener: _resource_record_post_action 19:45:22 INFO - Running post-action listener: _start_resource_monitoring 19:45:22 INFO - Starting resource monitoring. 19:45:22 INFO - ##### 19:45:22 INFO - ##### Running install step. 19:45:22 INFO - ##### 19:45:22 INFO - Running pre-action listener: _resource_record_pre_action 19:45:22 INFO - Running main action method: install 19:45:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:45:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:45:22 INFO - Reading from file tmpfile_stdout 19:45:22 INFO - Detecting whether we're running mozinstall >=1.0... 19:45:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:45:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:45:22 INFO - Reading from file tmpfile_stdout 19:45:22 INFO - Output received: 19:45:22 INFO - Usage: mozinstall [options] installer 19:45:22 INFO - Options: 19:45:22 INFO - -h, --help show this help message and exit 19:45:22 INFO - -d DEST, --destination=DEST 19:45:22 INFO - Directory to install application into. [default: 19:45:22 INFO - "/builds/slave/test-pgo"] 19:45:22 INFO - --app=APP Application being installed. [default: firefox] 19:45:22 INFO - mkdir: /builds/slave/test-pgo/build/application 19:45:22 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'] 19:45:22 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 19:45:37 INFO - Reading from file tmpfile_stdout 19:45:37 INFO - Output received: 19:45:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:45:37 INFO - Running post-action listener: _resource_record_post_action 19:45:37 INFO - ##### 19:45:37 INFO - ##### Running run-tests step. 19:45:37 INFO - ##### 19:45:37 INFO - Running pre-action listener: _resource_record_pre_action 19:45:37 INFO - Running main action method: run_tests 19:45:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:45:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:45:37 INFO - Python 2.7.3 19:45:37 INFO - Return code: 0 19:45:37 INFO - grabbing minidump binary from tooltool 19:45: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')]} 19:45:37 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 0x25da350>, '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 0x25db250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25db6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:45:37 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 19:45:37 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 19:45:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:45:37 INFO - Return code: 0 19:45:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:45:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:45:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:45:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:45:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:45:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:45:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:45:38 INFO - Return code: 0 19:45:38 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/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:45:38 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/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 19:45:38 INFO - Using env: {'DISPLAY': ':0', 19:45:38 INFO - 'HOME': '/home/cltbld', 19:45:38 INFO - 'LANG': 'en_US.UTF-8', 19:45:38 INFO - 'LANGUAGE': 'en_US:en', 19:45:38 INFO - 'LOGNAME': 'cltbld', 19:45:38 INFO - 'MAIL': '/var/mail/cltbld', 19:45:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:45:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:38 INFO - 'MOZ_NO_REMOTE': '1', 19:45:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:38 INFO - 'NO_EM_RESTART': '1', 19:45:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:38 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:45:38 INFO - 'SHELL': '/bin/bash', 19:45:38 INFO - 'SHLVL': '1', 19:45:38 INFO - 'TERM': 'linux', 19:45:38 INFO - 'TMOUT': '86400', 19:45:38 INFO - 'USER': 'cltbld', 19:45:38 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181', 19:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:38 INFO - '_': '/tools/buildbot/bin/python'} 19:45:38 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/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 19:45:38 INFO - mozversion INFO | application_buildid: 20151216173017 19:45:38 INFO - mozversion INFO | application_changeset: a8f8ec75a2a9b81aa3963ff6c330133adbd095d5 19:45:38 INFO - mozversion INFO | application_display_name: Nightly 19:45:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:45:38 INFO - mozversion INFO | application_name: Firefox 19:45:38 INFO - mozversion INFO | application_remotingname: firefox 19:45:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:45:38 INFO - mozversion INFO | application_vendor: Mozilla 19:45:38 INFO - mozversion INFO | application_version: 46.0a1 19:45:38 INFO - mozversion INFO | platform_buildid: 20151216173017 19:45:38 INFO - mozversion INFO | platform_changeset: a8f8ec75a2a9b81aa3963ff6c330133adbd095d5 19:45:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:45:38 INFO - mozversion INFO | platform_version: 46.0a1 19:45:38 INFO - 2015-12-16 19:45:38,738 DEBUG : using testdate: 1450323938 19:45:38 INFO - 2015-12-16 19:45:38,738 DEBUG : actual date: 1450323938 19:45:38 INFO - 2015-12-16 19:45:38,748 INFO : starting webserver on 'localhost:52060' 19:45:38 INFO - 2015-12-16 19:45:38,749 INFO : Starting test suite talos-linux64-ix-029 19:45:38 INFO - 2015-12-16 19:45:38,749 INFO : Starting test dromaeo_css 19:45:38 INFO - 2015-12-16 19:45:38,749 DEBUG : operating with platform_type : linux_ 19:45:38 INFO - 2015-12-16 19:45:38,750 INFO : Initialising browser for dromaeo_css test... 19:45:38 INFO - 2015-12-16 19:45:38,766 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXeHiB_/profile http://localhost:52060/getInfo.html 19:45:43 INFO - 2015-12-16 19:45:43,353 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:45:43 INFO - 2015-12-16 19:45:43,353 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:45:43 INFO - 2015-12-16 19:45:43,354 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:45:43 INFO - 2015-12-16 19:45:43,354 DEBUG : BROWSER_OUTPUT: __metrics 19:45:43 INFO - 2015-12-16 19:45:43,455 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] 19:45:43 INFO - 2015-12-16 19:45:43,503 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] 19:45:44 INFO - 2015-12-16 19:45:44,336 INFO : Browser initialized. 19:45:44 INFO - 2015-12-16 19:45:44,336 INFO : Running cycle 1/1 for dromaeo_css test... 19:45:44 INFO - 2015-12-16 19:45:44,336 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXeHiB_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:45:56 INFO - 2015-12-16 19:45:56,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 142032896 19:45:56 INFO - 2015-12-16 19:45:56,277 DEBUG : BROWSER_OUTPUT: 19:46:46 INFO - 2015-12-16 19:46:46,949 DEBUG : BROWSER_OUTPUT: 1450324006945 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] 19:48:56 INFO - 2015-12-16 19:48:56,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52060/tests/dromaeo/cssquery-ext.html) 19:48:57 INFO - 2015-12-16 19:48:57,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 256995328 19:48:57 INFO - 2015-12-16 19:48:57,739 DEBUG : BROWSER_OUTPUT: 19:52:00 INFO - 2015-12-16 19:52:00,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-ext.html (next: http://localhost:52060/tests/dromaeo/cssquery-jquery.html) 19:52:00 INFO - 2015-12-16 19:52:00,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 223694848 19:52:00 INFO - 2015-12-16 19:52:00,769 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-16 19:55:02,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52060/tests/dromaeo/cssquery-mootools.html) 19:55:03 INFO - 2015-12-16 19:55:03,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 216666112 19:55:03 INFO - 2015-12-16 19:55:03,283 DEBUG : BROWSER_OUTPUT: 19:58:05 INFO - 2015-12-16 19:58:05,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52060/tests/dromaeo/cssquery-prototype.html) 19:58:05 INFO - 2015-12-16 19:58:05,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 202973184 19:58:05 INFO - 2015-12-16 19:58:05,708 DEBUG : BROWSER_OUTPUT: 20:01:08 INFO - 2015-12-16 20:01:08,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52060/tests/dromaeo/cssquery-yui.html) 20:01:08 INFO - 2015-12-16 20:01:08,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 204926976 20:01:08 INFO - 2015-12-16 20:01:08,759 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/dromaeo/cssquery-yui.html (next: http://localhost:52060/tests/dromaeo/cssquery-dojo.html) 20:04:11 INFO - 2015-12-16 20:04:11,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 245313536 20:04:11 INFO - 2015-12-16 20:04:11,611 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:04:11 INFO - 2015-12-16 20:04:11,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:04:11 INFO - 2015-12-16 20:04:11,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:04:11 INFO - 2015-12-16 20:04:11,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:04:11 INFO - 2015-12-16 20:04:11,613 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3149.385869755398;3185.1877771168347;3199.6960288772575;3223.7904536205147;3249.41510528105;5180.197069454241;5261.447548007452;5315.68105913645;5357.973210133949;5450.209719590657;5261.86845328867;5318.388385335687;5340.759665815038;5408.756605952732;5451.563874890009;4934.531219534148;4935.087008903364;4969.950300497003;4986.501349865002;5089.541941225289;4967.627427942901;5090.109230884599;5094.46508116648;5113.156329205676;5113.5909127269915;4715.481297057321;4812.951870481285;4842.975785121052;4973.701577905337;5038.748062596874;4988.476209997971;4999.600031997432;5001.724905130216;5001.9499805002215;5050.924236136461;4951.084049450863;4958.7024778513405;4964.8758781030765;4970.453250142481;4986.476419975923;5085.338905942241;5127.384713834326;5186.196139598331;5203.843884683465;5205.349331333583;5770.394108618577;5806.82579522615;5814.796482123105;5815.476607105338;5818.185454036438;5744.569157313218;5810.099434587646;5908.645481271137;5915.526757859361;5917.319508256563;5267.736613169364;5307.336582927134;5348.197770334481;5477.972610136963;5490.6431081979545;5898.793542226087;5909.2908850938165;5911.793087241926;5919.4968427684125;5923.348431672513;5431.945680543223;5754.136879468113;5755.251817263729;5755.59710820247;5766.567507436959;5733.799317023968;5782.479576838021;5819.563532735062;5915.260592425947;5927.377625349276;5814.941850581525;5823.650580965155;5847.8245652630485;5851.268591426072;5851.590388672752;5853.356130825606;5858.47273745365;5864.794732184353;5870.090136028923;5871.7651293947765;4356.738595684269;4412.051408947092;4433.069055498381;4494.977525112354;4501.504834468205;3984.382420724792;3984.7011474139554;4005;4019.21625283067;4051.7366371186367;5510.1459273812625;5547.417521160301;5563.082091454946;5565.2191298784;5609.887802243932;5725.914111288334;5781.884362312814;5855.736491857877;5857.531397488191;5858.882822343615;5493.670379777226;5529.751161197756;5560.082586373284;5561.054620714407;5564.554835613141;4949.752512374439;4959.628027897922;4959.925601115986;4966.925496117489;5001.1498045331655;5852.502537284294;5942;6013.939860601426;6032.607880487754;6039.063945088518;5816.098504731774;5823.126531020381;5888.499477544457;5900;5947.10793380979;5907.881842363215;5915.792947246826;5916;5917.644941303363;5921.851953701192;5561.499465048165;5626.099824028136;5684.431556844283;5736.42635736423;5745.597808153389;5734.971325143348;5844.590878638454;5956.047032474957;5966.0454327307425;5967.582269241111;5817.912731308949;5831.679257640871;5831.708414579339;5832.62087964281;5835.416458354131;5554.361248456317;5661.745221464962;5780.364159942487;5798.797042103506;5800.100984347433;5517.69652669107;5575.8884822304135;5577.637453565505;5596.0206963780365;5620.072688006597;5735.426457354231;5741.282339707536;5751.913721294268;5753.884922301447;5817.360090389969;5391.460853914734;5448.4006759257245;5541.861453463695;5585.5252303553025;5589.496945274782 20:04:11 INFO - 2015-12-16 20:04:11,614 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.8211809705953;594.2720167794452;602.5089552015107;604.9122877182807;618.5608218165108;27929.860350698244;38425.80787096064;39471.99999999996;39492.210155796936;39550.40674389879;42484.36273455901;43051;43090.569094309045;43132.56867431325;43152.784236078776;7579.279968403021;7711.5758633275145;7714.768556943301;8724.869126963085;8898.466092034467;7680.116786569532;10458.686239412791;10632.681019569425;10685.519151638195;10690.518926648281;10370.585176592966;10403.687889363331;10456.895431045668;10469.267151299413;10484.213683973694;7834.921650783476;8010.639521221559;10355.275130740814;10470;10471.947640261826;10509.947450262776;10761.08530774885;10768.3538987661;10771.56913723458;10783.730406739895;40262.194756105004;40270.19459610791;40544.79727601343;40589.59410405887;40724.59275407238;3309.4373956427467;3310.420676381648;3339.716124129452;3340.1482621931495;3350.8659653613827;30164.396712065856;30183.849080754677;30297.091087267418;30674.846625766728;30715.232119196975;3468.6052880545685;3473.7915725056578;3518.1204698825295;3540.1149712571855;3632.7275454340765;274971;275098;275235.6238218816;275913;276669;54477;55397;55978;56946.43053569494;57179.71410142923;56007;56135.43864561384;56231.71884140635;56492.717536412056;56692.71653641705;13286.800697989538;13377.933110334387;13396.26320552379;13401.396937137852;13562.728745425036;10272.640457584099;10274.589016439408;10281.897181028244;10360.720641458867;10389.53247103867;18773.530661733566;18794.53013674669;18904.243830246636;18912.527186820163;19063.90468047651;7241;7480.625968701544;7543.547387156788;7592.81017974555;7598.278163574451;927.3554879358916;941.8775559177263;984.9852252216223;1031.4997226345217;1103.9558417663204;28480.572791408147;28754.424911501654;28965.275868103465;29126;29374.559381608866;960.2345245692501;1034.7051090439188;1070.550368845087;1123.3996783173056;1174.864890537582;15137.697246055017;15150.924245378923;15221.31504082319;15324.616884577974;15389.384424623113;321110;325022;326031;326225;328025;51953.220701689504;52052.739736301075;52206;52207;52253.7387313061;1278.8337516122845;1301.1477482249143;1303.5958852755675;1304.230504002643;1314.769915264825;27368.863155684096;28364.290892727848;28566.85716571487;28634.57048144321;28868.711312886604;45737;46039.76980115078;46076;46090.308645369674;46133.538664614265;298566;298604;299201;299906;300280;27194.592081119194;30269;30613.387732244784;30720;30979.225519362197;36792.63207367892;37369.813150934075;37872.62127378801;37927;41209.38185927153;35042.824785875906;35106.82446587751;35237.11907202341;35342.82328588341;36044.27911441809;29406;31984;33736.49395259024;34895;35225;34075.488867667504;34409.48385774165;34550.30899381948;34897.65102348944;34900.301993959474;31228.687713122577;32458.83770581132;32502.34995300128;32506;32612.83693581517;24528;24674.13640522573;24770.876145619877;24950.50098998046;25170.74829251684 20:04:11 INFO - 2015-12-16 20:04:11,616 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.05031192495846;359.36930686644945;359.7426992660653;359.94240921452564;362.69352397224367;13615.45538178474;13622.569630188837;16310.836891631096;16554.337826486943;17227.483175504738;11746.7650646987;12086.21439606425;14117.223552704598;14134;14439.422423103064;5364.409914909366;5507.972460137694;5508.531774799127;5508.889822203553;5511.035568775468;3921.8235179416993;4019.738716983387;5320.6275560710765;5406.83779486616;5437.619366644337;5754.971225143869;5856.297244330686;5897.351291357947;5900.940990590082;5902.675352855591;5400.945990540084;5411.269478620376;5589.273394458714;5849.736761845727;5875.618084824473;5090.33825602673;5157.329547158883;5164.896702065976;5166.819161329373;5168.689878607295;20383.286584969603;20397.184112635627;20699.379018629315;20719.58560828775;20723.896380518;1953.667876461005;2326.627739561662;2386.343755467243;2399.484110916144;2490.750924907513;9450.149486546245;9669.516524173763;9681.419114853132;9830.803383932353;9930.851037234448;1801.8018018017997;1830.2495976649643;1862.4319582527323;1866.4680566038614;1881.106474424651;56117.43882561204;56478.152827707614;56651.71674141644;57246.713766430905;61746.69126654383;9488.95255523718;9773.609055637695;9796.26528010402;9802.264830137769;9818.116369526777;12987.805182922264;13080.476780928657;13117;13127;13132.015098867623;7118.71525138999;7149.964250178716;7161.67772450241;7180.281971802778;7205.603691796897;6812.4550035997;6825.283345248777;6828.00993855898;6830.180378354629;6841.486888483384;4269.338252570857;4302.3546468030045;4313.396124542566;4342.109867477159;4346.239408103569;1638.0744879143247;1679.41220572801;1767.8585713142918;1793.6950718377907;1795.1921635264184;409.0673264955905;413.5492313378432;428.4323271664994;954.0364232125603;1006.6476733143488;10004.299699021145;10757.354558726502;10796.67609971702;10833.29583577065;10930;419.9622034016953;423.9152169566099;425.8105143211303;446.15899030328063;447.4786873292643;5351.946480535223;5946.43508866657;5995.430434108753;6005.279366475964;6013.1581578579035;540874;544778;556520;559565;571009;72132;72180.94438176889;81248.18751812406;84331.5783421079;85126.57436712777;1132.105636547135;1137.852079229695;1167.095500986725;1193.964181074569;1197.9341136237417;15917.602059948595;16038.518844434686;16211.756823647891;16221.918890405472;16245.756313655542;34865.12837178989;35173.47239791354;35394.46908296429;35858;36465.453018204214;45637.77181114073;48094.75952620214;48632.270515943;48915;52515;9116.726498205064;9329.440233585736;9411.058894110534;9417.199538039344;9585.520723963635;11523.308601483937;11562.248453850472;11674.883251167379;12599.43302551369;17549.561260968578;11023;13401.32993350348;13420.060595758594;13454.596362109152;13504.527341543391;14074.995379596958;14206.21865797391;14557.27213639335;14566.635834104232;14595.416183352547;10998.615048473264;13805.51680691171;14194.077384969944;14297;15405.306761195548;9489.762755931157;9508.952455237679;9582.377145485521;9597.856032159663;9608.855867162138;9871.50642467888;9948.054934781185;10905;14653.70692586121;15115.395384184509 20:04:11 INFO - 2015-12-16 20:04:11,617 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1337.1776357540116;1438.5756201920433;1495.7905893174955;1611.677664467107;1737.2877120380647;6395.104685344056;7220.711171553138;7351.4486413519;7357.705691772323;7360.2271761464945;7410.147832999207;7572.091349038109;7577.204393538682;7581.469297149201;7596.734114306;1955.5795503966644;2008.1866843928233;2218;2228.621134407155;2257.7177852768405;2268.9546209075806;2269.375921621551;2269.8524595901295;2271.65925111233;2272.7954484096426;2210.370044537307;2257.4356410897276;2260.5930932432157;2260.9660855087186;2263.094762095167;2222.9110835566557;2244.921427750029;2258.4128126687015;2261.9886900565557;2275.613145765224;2248.4154119928935;2264.9886750566307;2272.1479445208047;2293.3693234360517;2297.4371279036577;7579.696812127509;7648.120466146409;7664.7317343893255;7673.46285759997;7678.040244969379;4408.448943882015;4436.134953684033;4466.598006179427;4505.098980203939;4510;2942.9705702943124;3015.366772977677;3052.786304958654;3053;3064.1420402287395;996.8056229035341;998;1013.5084484025242;1027.9537420816082;1028.2134167361974;10231.744206394826;10243.79512409755;10246.436445995467;10258.692239232834;10262.589496420134;4227.217964676544;4261.978690106592;4325.502567204749;4330.610245077895;4330.913381732411;8873.068327825486;8882.733517994471;8882.822343553093;8886.822263554694;8892.73321800347;4537.659675524283;4538.977305113453;4584.243599805995;4585.656075794329;4593;4127.8968025798995;4128.896777580585;4129.97935010323;4130.277201489727;4131.855385061508;3289.588801399825;3303.785253958485;3342.615599206074;3439.1402149462633;3529.3294274087843;1147.1854982962022;1168.9590864319707;1169.2516789254885;1191.7199458127334;1191.9582814601447;1063.4416931111073;1064.180580952662;1096.1395304685784;1210.7094297368744;1343.8253027106414;7162.068931039036;7238;7247.565146091251;7249.130104387507;7350.33846953766;1023.3450591621369;1032.2516175772505;1035.8756949166147;1039.7452624107143;1133.631569739838;5774.335951365562;5815.098659707752;5852.15143804146;5860.062390017577;5873.706314684334;8998.55007249635;9248.815023699623;9300.767480812898;9312.255019598417;9320.207782338577;8864.778380540409;9016.233620142362;9063.501507417024;9194.356395052282;9212.631494740135;6908.585484870823;6946.930530694831;6948;6949.061876646588;6956.79129626112;6931.89602155958;7001;7023.297670232936;7030.894536582057;7033.824154395977;7832.569208693577;8115.634796434293;8202.876956845532;8228.794280143044;8259.21537453941;8029.156938521604;8179.018517777905;8348.248657620843;8363.289120424832;8363.49819010837;6223.284322302993;6339.778107766206;6345.746170153327;6346.174997250328;6347.619142851259;6569.835754106186;6652.201735791736;7039.859202815813;7126.180489243803;7460.104787425326;6755.695993680394;6864.759733409506;6907.758228461979;7019.964900175671;7040.119985001875;6776.93223067763;6804.795856124324;6820.35206655367;6895.862082758417;6951.617661028489;6888.070110535014;6914;6919.619420931897;6924.93075069263;6927.376536111774;6178.876422471435;6199.969000155151;6210.875782484415;6401.199850018747;6455.128557644845;6513.348665133449;6529.281779004401;6531.314212007861;6542.280349161493;6543.411093001652 20:04:11 INFO - 2015-12-16 20:04:11,618 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.0428713858425;321.8776864791379;323.9287356781507;328.77643202622215;328.829008915364;5870.765169393219;5986.910196347058;5987.161797348369;6009.489193418559;6030.306514750805;5786.913196302059;5891.204687367204;5906.37983011784;5927.970360148193;5929.2884853817495;4628.791704373311;4634.930476042862;4635.559621835929;4636.97681511592;4645.792094055536;4413.360062790894;4518.938049558351;4521.186186486431;4605.30920361945;4645;4538.546145385468;4539.7957091930775;4540.18276710192;4546.727196368212;4560.293154561032;4550.658700597452;4555.157295900269;4560.156371071363;4566.06395688883;4568.428946381702;3978.562358140602;3981.5620281768984;3984.7409918355215;3989.364360612135;4005.539362973237;5572.3034620672415;5667.5749318800845;5675.886482270373;5720.342160651495;5734.569907256972;5311.62818602698;5319.494648008472;5319.760610772524;5320.65415747979;5326.547243484309;6036.396360363972;6373.171487706569;6378.776742814026;6379.872402551923;6383.840403989891;4340.305551111838;4354.499232588261;4403.4495688039;4411.6250118739945;4414.470263568361;6455.741770329181;6558.376954189344;6567.573107747981;6570.868582628368;6581.90127148098;4493.460784705856;4496.505384407713;4498.302763071729;4498.707584007029;4500.482444518857;4459.487158976694;4547.2269714148015;4549.3176023596725;4552.112338094106;4556.88607784808;5262.684238945675;5264.236685680631;5267.71027593486;5269.972355390739;5282.339707536558;6333.493320534346;6378.489720822323;6385.48916086712;6391;6399.072134540559;1620.181808186858;1632.037098112096;1633.9918300408422;1634.4687976407715;1635.1987526112118;1093.3822390349428;1093.8577984861918;1104.2215238257008;1120.882307357732;1128.0017184791518;6126.571140020245;6139.386061393825;6141.017437210115;6142.232220972379;6154.076888466676;6610.6694665267505;6615.503837212228;6618.735250590019;6619.933800662028;6620.172478440195;5986.46121849027;6132.264128304543;6134.570580059353;6139.324674285825;6147.631142131487;3567.839447224881;3592.8023958682525;3594.712423006153;3595.7123430125525;3598.514200582888;6703.994400839913;6720.6975686093265;6723.462123030145;6726.562773419712;6731.326867313327;6609.900851487231;6741.426978706865;6749.3250674932115;6750.831229219309;6760.763373281911;6660.533762636665;6667.699953502104;6698.665066746643;6706;6710.188249172696;6360;6538.869222615616;6584.374484423972;6587.901181482377;6589.6705164740615;6446.4520515756685;6448.032795080775;6455.225372955276;6463.15978922737;6566.277709451861;6747.831304217238;6750.696218670269;6758.560693554903;6772.492063095189;6775.49183811226;4455.465344158722;4538.954610453853;4544.113897789899;4544.818207271672;4567.2007398705755;6654.367835055662;6655;6655.467562595078;6659.667016649051;6664.200295964515;6413.615183089029;6472.352764723679;6475.449586784987;6475.805725828232;6478.805635830932;6298.0867774171575;6389.68051597409;6451.580647257913;6461.19235095613;6471.191101112361;6345.682715864281;6350.952092904804;6351.047342898602;6354.586951848115;6358.809235722936;6491.610503369813;6498.350164983653;6503.926852069356;6504.869902601827;6509.056186852785;6075.574709770451;6241.063840423791;6267.811965641038;6289.591176573508;6294.087357333069 20:04:11 INFO - 2015-12-16 20:04:11,619 DEBUG : BROWSER_OUTPUT: |5;yui.html;743.788020414182;756.5082696247439;779.7076096463826;782.0224719101121;842.9241368276855;13693.794593081111;13991;14001.929990350034;14006;14006.29968501576;10648.254622176451;13190.736185276288;13200;13220.669483262924;13278.800817987738;659.5877576514679;801.3589128697048;827.0612854410258;830.8172202115525;831.9725139452771;822.5517093184229;828.8922440082811;831.2020460358063;835.3943391041477;836.6695155413609;705.5272967112022;710.985780284394;862.5945805471418;866.445474896067;869.148234729965;850.642730053376;857.7855536115972;864.0236532718051;864.4078806017898;864.8529749942494;638.2851206648537;639.7536948274948;640.6572483721234;640.8461969127376;641.0864518061743;13499.527516536973;13664.93167534156;13666.658333541642;13690.452381904712;13694.794578081337;11899;12171.026317894635;12189.634310970596;12684.365781710878;12742;9913.65302214419;10073.949630251802;10077.193824494023;10122.595096196143;10306.123979461754;3619.8371073301764;3631.346357655621;3661.359262129143;3752.9437058444146;3757.7369584129124;44257.33613995793;44546.10907781859;44562.77718611419;44800;44800.55199448029;9679.274054445945;9682.467464289392;9707.611695532241;9831.754206144904;10058.245631577662;18064.36774712879;18069.7289540657;18085;18113.547161321072;18128.728069078974;7212.098487689039;7316.597587132759;7404.370628496638;7462.701491940262;7602.619869006528;3988.501437320335;4057.2494088593703;4137.110521237948;4145.419641250227;4175.373693945871;3001.294695746498;3039.7264246217946;3043.680413556545;3062.892798752033;3064.249258931576;547.0672503381725;550.1280470454295;557.2115456628906;570.5093619487237;571.725571725574;653.5752060508138;653.6927644007309;672.89570116632;695.9269276725972;700.3906601256939;8517.74446766598;8610.913890861011;8664.436811607226;8680.826383472295;8836.690715824916;567.8041075828914;629.6033498895758;694.9826254343682;727.6761840980819;728.1517032656895;4285.785710714452;4335.7181783184;4370.409994650681;4401.977990110029;4457.618479718534;53472;53740.19389709157;54147;54154.458455415726;60376;47992;48053.75973120112;48387.75806120947;48577.028459430614;48983.265251021265;42668.57331426708;43539.782301088926;43902.34146487805;44816.3277550837;45267.09465810665;8227.506349619041;8601.569921504026;8699.608517616596;8811.603477843384;9025.277977761894;33805.32389352249;34119.48820767641;35196.296074078884;35366;36814.63185368112;42057;42838.14323713571;42878.35682464703;43327.566724333614;43802.34296485491;10480.475976201313;10798.244122911321;10858.728531786768;11089;11101.777964440504;12349.444275007467;12376.75246495083;12390.75218495607;12467;12551.05867059956;11382.487788049391;11703.769560809145;11845.822312665145;12035.819462707892;12152.453139608562;11529.711757206136;11621.418929053345;11739.882601173878;12201.14591978553;12335.629931102081;8146.348292136497;11175.88824111781;11392.316461012366;11453.770924581628;11671.766564668489;9887.357321774061;10266.486675666038;10341.63804266847;10525.736856578647;10526.78540447018;9876.111149996535;9974.800503990025;9979.39329093102;10076.84884726715;10094.343867648578 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,865 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: __startTimestamp1450325051610__endTimestamp 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:04:11 INFO - 2015-12-16 20:04:11,620 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,621 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5399.71 Median:5577.64 stddev:607.30 (10.9%) stddev-sans-first:582.94 20:04:11 INFO - 2015-12-16 20:04:11,621 DEBUG : BROWSER_OUTPUT: Values: 3149.4 3185.2 3199.7 3223.8 3249.4 5180.2 5261.4 5315.7 5358.0 5450.2 5261.9 5318.4 5340.8 5408.8 5451.6 4934.5 4935.1 4970.0 4986.5 5089.5 4967.6 5090.1 5094.5 5113.2 5113.6 4715.5 4813.0 4843.0 4973.7 5038.7 4988.5 4999.6 5001.7 5001.9 5050.9 4951.1 4958.7 4964.9 4970.5 4986.5 5085.3 5127.4 5186.2 5203.8 5205.3 5770.4 5806.8 5814.8 5815.5 5818.2 5744.6 5810.1 5908.6 5915.5 5917.3 5267.7 5307.3 5348.2 5478.0 5490.6 5898.8 5909.3 5911.8 5919.5 5923.3 5431.9 5754.1 5755.3 5755.6 5766.6 5733.8 5782.5 5819.6 5915.3 5927.4 5814.9 5823.7 5847.8 5851.3 5851.6 5853.4 5858.5 5864.8 5870.1 5871.8 4356.7 4412.1 4433.1 4495.0 4501.5 3984.4 3984.7 4005.0 4019.2 4051.7 5510.1 5547.4 5563.1 5565.2 5609.9 5725.9 5781.9 5855.7 5857.5 5858.9 5493.7 5529.8 5560.1 5561.1 5564.6 4949.8 4959.6 4959.9 4966.9 5001.1 5852.5 5942.0 6013.9 6032.6 6039.1 5816.1 5823.1 5888.5 5900.0 5947.1 5907.9 5915.8 5916.0 5917.6 5921.9 5561.5 5626.1 5684.4 5736.4 5745.6 5735.0 5844.6 5956.0 5966.0 5967.6 5817.9 5831.7 5831.7 5832.6 5835.4 5554.4 5661.7 5780.4 5798.8 5800.1 5517.7 5575.9 5577.6 5596.0 5620.1 5735.4 5741.3 5751.9 5753.9 5817.4 5391.5 5448.4 5541.9 5585.5 5589.5 20:04:11 INFO - 2015-12-16 20:04:11,621 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,621 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46442.27 Median:178764.00 stddev:78620.32 (44.0%) stddev-sans-first:78765.38 20:04:11 INFO - 2015-12-16 20:04:11,621 DEBUG : BROWSER_OUTPUT: Values: 555.8 594.3 602.5 604.9 618.6 27929.9 38425.8 39472.0 39492.2 39550.4 42484.4 43051.0 43090.6 43132.6 43152.8 7579.3 7711.6 7714.8 8724.9 8898.5 7680.1 10458.7 10632.7 10685.5 10690.5 10370.6 10403.7 10456.9 10469.3 10484.2 7834.9 8010.6 10355.3 10470.0 10471.9 10509.9 10761.1 10768.4 10771.6 10783.7 40262.2 40270.2 40544.8 40589.6 40724.6 3309.4 3310.4 3339.7 3340.1 3350.9 30164.4 30183.8 30297.1 30674.8 30715.2 3468.6 3473.8 3518.1 3540.1 3632.7 274971.0 275098.0 275235.6 275913.0 276669.0 54477.0 55397.0 55978.0 56946.4 57179.7 56007.0 56135.4 56231.7 56492.7 56692.7 13286.8 13377.9 13396.3 13401.4 13562.7 10272.6 10274.6 10281.9 10360.7 10389.5 18773.5 18794.5 18904.2 18912.5 19063.9 7241.0 7480.6 7543.5 7592.8 7598.3 927.4 941.9 985.0 1031.5 1104.0 28480.6 28754.4 28965.3 29126.0 29374.6 960.2 1034.7 1070.6 1123.4 1174.9 15137.7 15150.9 15221.3 15324.6 15389.4 321110.0 325022.0 326031.0 326225.0 328025.0 51953.2 52052.7 52206.0 52207.0 52253.7 1278.8 1301.1 1303.6 1304.2 1314.8 27368.9 28364.3 28566.9 28634.6 28868.7 45737.0 46039.8 46076.0 46090.3 46133.5 298566.0 298604.0 299201.0 299906.0 300280.0 27194.6 30269.0 30613.4 30720.0 30979.2 36792.6 37369.8 37872.6 37927.0 41209.4 35042.8 35106.8 35237.1 35342.8 36044.3 29406.0 31984.0 33736.5 34895.0 35225.0 34075.5 34409.5 34550.3 34897.7 34900.3 31228.7 32458.8 32502.3 32506.0 32612.8 24528.0 24674.1 24770.9 24950.5 25170.7 20:04:11 INFO - 2015-12-16 20:04:11,621 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,621 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28580.81 Median:2347.57 stddev:90690.15 (3863.1%) stddev-sans-first:90919.80 20:04:11 INFO - 2015-12-16 20:04:11,622 DEBUG : BROWSER_OUTPUT: Values: 359.1 359.4 359.7 359.9 362.7 13615.5 13622.6 16310.8 16554.3 17227.5 11746.8 12086.2 14117.2 14134.0 14439.4 5364.4 5508.0 5508.5 5508.9 5511.0 3921.8 4019.7 5320.6 5406.8 5437.6 5755.0 5856.3 5897.4 5900.9 5902.7 5400.9 5411.3 5589.3 5849.7 5875.6 5090.3 5157.3 5164.9 5166.8 5168.7 20383.3 20397.2 20699.4 20719.6 20723.9 1953.7 2326.6 2386.3 2399.5 2490.8 9450.1 9669.5 9681.4 9830.8 9930.9 1801.8 1830.2 1862.4 1866.5 1881.1 56117.4 56478.2 56651.7 57246.7 61746.7 9489.0 9773.6 9796.3 9802.3 9818.1 12987.8 13080.5 13117.0 13127.0 13132.0 7118.7 7150.0 7161.7 7180.3 7205.6 6812.5 6825.3 6828.0 6830.2 6841.5 4269.3 4302.4 4313.4 4342.1 4346.2 1638.1 1679.4 1767.9 1793.7 1795.2 409.1 413.5 428.4 954.0 1006.6 10004.3 10757.4 10796.7 10833.3 10930.0 420.0 423.9 425.8 446.2 447.5 5351.9 5946.4 5995.4 6005.3 6013.2 540874.0 544778.0 556520.0 559565.0 571009.0 72132.0 72180.9 81248.2 84331.6 85126.6 1132.1 1137.9 1167.1 1194.0 1197.9 15917.6 16038.5 16211.8 16221.9 16245.8 34865.1 35173.5 35394.5 35858.0 36465.5 45637.8 48094.8 48632.3 48915.0 52515.0 9116.7 9329.4 9411.1 9417.2 9585.5 11523.3 11562.2 11674.9 12599.4 17549.6 11023.0 13401.3 13420.1 13454.6 13504.5 14075.0 14206.2 14557.3 14566.6 14595.4 10998.6 13805.5 14194.1 14297.0 15405.3 9489.8 9509.0 9582.4 9597.9 9608.9 9871.5 9948.1 10905.0 14653.7 15115.4 20:04:11 INFO - 2015-12-16 20:04:11,622 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,622 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5304.10 Median:6217.08 stddev:2726.17 (43.8%) stddev-sans-first:2717.51 20:04:11 INFO - 2015-12-16 20:04:11,623 DEBUG : BROWSER_OUTPUT: Values: 1337.2 1438.6 1495.8 1611.7 1737.3 6395.1 7220.7 7351.4 7357.7 7360.2 7410.1 7572.1 7577.2 7581.5 7596.7 1955.6 2008.2 2218.0 2228.6 2257.7 2269.0 2269.4 2269.9 2271.7 2272.8 2210.4 2257.4 2260.6 2261.0 2263.1 2222.9 2244.9 2258.4 2262.0 2275.6 2248.4 2265.0 2272.1 2293.4 2297.4 7579.7 7648.1 7664.7 7673.5 7678.0 4408.4 4436.1 4466.6 4505.1 4510.0 2943.0 3015.4 3052.8 3053.0 3064.1 996.8 998.0 1013.5 1028.0 1028.2 10231.7 10243.8 10246.4 10258.7 10262.6 4227.2 4262.0 4325.5 4330.6 4330.9 8873.1 8882.7 8882.8 8886.8 8892.7 4537.7 4539.0 4584.2 4585.7 4593.0 4127.9 4128.9 4130.0 4130.3 4131.9 3289.6 3303.8 3342.6 3439.1 3529.3 1147.2 1169.0 1169.3 1191.7 1192.0 1063.4 1064.2 1096.1 1210.7 1343.8 7162.1 7238.0 7247.6 7249.1 7350.3 1023.3 1032.3 1035.9 1039.7 1133.6 5774.3 5815.1 5852.2 5860.1 5873.7 8998.6 9248.8 9300.8 9312.3 9320.2 8864.8 9016.2 9063.5 9194.4 9212.6 6908.6 6946.9 6948.0 6949.1 6956.8 6931.9 7001.0 7023.3 7030.9 7033.8 7832.6 8115.6 8202.9 8228.8 8259.2 8029.2 8179.0 8348.2 8363.3 8363.5 6223.3 6339.8 6345.7 6346.2 6347.6 6569.8 6652.2 7039.9 7126.2 7460.1 6755.7 6864.8 6907.8 7020.0 7040.1 6776.9 6804.8 6820.4 6895.9 6951.6 6888.1 6914.0 6919.6 6924.9 6927.4 6178.9 6200.0 6210.9 6401.2 6455.1 6513.3 6529.3 6531.3 6542.3 6543.4 20:04:11 INFO - 2015-12-16 20:04:11,623 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,623 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5322.84 Median:6033.35 stddev:1602.43 (26.6%) stddev-sans-first:1562.29 20:04:11 INFO - 2015-12-16 20:04:11,623 DEBUG : BROWSER_OUTPUT: Values: 319.0 321.9 323.9 328.8 328.8 5870.8 5986.9 5987.2 6009.5 6030.3 5786.9 5891.2 5906.4 5928.0 5929.3 4628.8 4634.9 4635.6 4637.0 4645.8 4413.4 4518.9 4521.2 4605.3 4645.0 4538.5 4539.8 4540.2 4546.7 4560.3 4550.7 4555.2 4560.2 4566.1 4568.4 3978.6 3981.6 3984.7 3989.4 4005.5 5572.3 5667.6 5675.9 5720.3 5734.6 5311.6 5319.5 5319.8 5320.7 5326.5 6036.4 6373.2 6378.8 6379.9 6383.8 4340.3 4354.5 4403.4 4411.6 4414.5 6455.7 6558.4 6567.6 6570.9 6581.9 4493.5 4496.5 4498.3 4498.7 4500.5 4459.5 4547.2 4549.3 4552.1 4556.9 5262.7 5264.2 5267.7 5270.0 5282.3 6333.5 6378.5 6385.5 6391.0 6399.1 1620.2 1632.0 1634.0 1634.5 1635.2 1093.4 1093.9 1104.2 1120.9 1128.0 6126.6 6139.4 6141.0 6142.2 6154.1 6610.7 6615.5 6618.7 6619.9 6620.2 5986.5 6132.3 6134.6 6139.3 6147.6 3567.8 3592.8 3594.7 3595.7 3598.5 6704.0 6720.7 6723.5 6726.6 6731.3 6609.9 6741.4 6749.3 6750.8 6760.8 6660.5 6667.7 6698.7 6706.0 6710.2 6360.0 6538.9 6584.4 6587.9 6589.7 6446.5 6448.0 6455.2 6463.2 6566.3 6747.8 6750.7 6758.6 6772.5 6775.5 4455.5 4539.0 4544.1 4544.8 4567.2 6654.4 6655.0 6655.5 6659.7 6664.2 6413.6 6472.4 6475.4 6475.8 6478.8 6298.1 6389.7 6451.6 6461.2 6471.2 6345.7 6351.0 6351.0 6354.6 6358.8 6491.6 6498.4 6503.9 6504.9 6509.1 6075.6 6241.1 6267.8 6289.6 6294.1 20:04:11 INFO - 2015-12-16 20:04:11,624 DEBUG : BROWSER_OUTPUT: 20:04:11 INFO - 2015-12-16 20:04:11,624 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13485.66 Median:24152.16 stddev:15153.85 (62.7%) stddev-sans-first:15166.15 20:04:11 INFO - 2015-12-16 20:04:11,624 DEBUG : BROWSER_OUTPUT: Values: 743.8 756.5 779.7 782.0 842.9 13693.8 13991.0 14001.9 14006.0 14006.3 10648.3 13190.7 13200.0 13220.7 13278.8 659.6 801.4 827.1 830.8 832.0 822.6 828.9 831.2 835.4 836.7 705.5 711.0 862.6 866.4 869.1 850.6 857.8 864.0 864.4 864.9 638.3 639.8 640.7 640.8 641.1 13499.5 13664.9 13666.7 13690.5 13694.8 11899.0 12171.0 12189.6 12684.4 12742.0 9913.7 10073.9 10077.2 10122.6 10306.1 3619.8 3631.3 3661.4 3752.9 3757.7 44257.3 44546.1 44562.8 44800.0 44800.6 9679.3 9682.5 9707.6 9831.8 10058.2 18064.4 18069.7 18085.0 18113.5 18128.7 7212.1 7316.6 7404.4 7462.7 7602.6 3988.5 4057.2 4137.1 4145.4 4175.4 3001.3 3039.7 3043.7 3062.9 3064.2 547.1 550.1 557.2 570.5 571.7 653.6 653.7 672.9 695.9 700.4 8517.7 8610.9 8664.4 8680.8 8836.7 567.8 629.6 695.0 727.7 728.2 4285.8 4335.7 4370.4 4402.0 4457.6 53472.0 53740.2 54147.0 54154.5 60376.0 47992.0 48053.8 48387.8 48577.0 48983.3 42668.6 43539.8 43902.3 44816.3 45267.1 8227.5 8601.6 8699.6 8811.6 9025.3 33805.3 34119.5 35196.3 35366.0 36814.6 42057.0 42838.1 42878.4 43327.6 43802.3 10480.5 10798.2 10858.7 11089.0 11101.8 12349.4 12376.8 12390.8 12467.0 12551.1 11382.5 11703.8 11845.8 12035.8 12152.5 11529.7 11621.4 11739.9 12201.1 12335.6 8146.3 11175.9 11392.3 11453.8 11671.8 9887.4 10266.5 10341.6 10525.7 10526.8 9876.1 9974.8 9979.4 10076.8 10094.3 20:04:11 INFO - 2015-12-16 20:04:11,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:04:11 INFO - 2015-12-16 20:04:11,624 DEBUG : BROWSER_OUTPUT: 20:04:12 INFO - 2015-12-16 20:04:12,305 INFO : Browser exited with error code: 0 20:04:12 INFO - 2015-12-16 20:04:12,321 INFO : Completed test dromaeo_css (00:18:33) 20:04:12 INFO - 2015-12-16 20:04:12,321 INFO : Starting test kraken 20:04:12 INFO - 2015-12-16 20:04:12,321 DEBUG : operating with platform_type : linux_ 20:04:12 INFO - 2015-12-16 20:04:12,322 INFO : Initialising browser for kraken test... 20:04:12 INFO - 2015-12-16 20:04:12,328 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdqTMw4/profile http://localhost:52060/getInfo.html 20:04:16 INFO - 2015-12-16 20:04:16,528 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:04:16 INFO - 2015-12-16 20:04:16,529 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:04:16 INFO - 2015-12-16 20:04:16,529 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:04:16 INFO - 2015-12-16 20:04:16,529 DEBUG : BROWSER_OUTPUT: __metrics 20:04:16 INFO - 2015-12-16 20:04:16,638 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] 20:04:16 INFO - 2015-12-16 20:04:16,679 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] 20:04:17 INFO - 2015-12-16 20:04:17,898 INFO : Browser initialized. 20:04:17 INFO - 2015-12-16 20:04:17,899 INFO : Running cycle 1/1 for kraken test... 20:04:17 INFO - 2015-12-16 20:04:17,899 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdqTMw4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:04:29 INFO - 2015-12-16 20:04:29,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 142626816 20:04:29 INFO - 2015-12-16 20:04:29,755 DEBUG : BROWSER_OUTPUT: 20:04:32 INFO - 2015-12-16 20:04:32,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-beat-detection) 20:04:32 INFO - 2015-12-16 20:04:32,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 178245632 20:04:32 INFO - 2015-12-16 20:04:32,780 DEBUG : BROWSER_OUTPUT: 20:04:35 INFO - 2015-12-16 20:04:35,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-dft) 20:04:35 INFO - 2015-12-16 20:04:35,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 166223872 20:04:35 INFO - 2015-12-16 20:04:35,913 DEBUG : BROWSER_OUTPUT: 20:04:38 INFO - 2015-12-16 20:04:38,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-fft) 20:04:39 INFO - 2015-12-16 20:04:39,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 151678976 20:04:39 INFO - 2015-12-16 20:04:39,375 DEBUG : BROWSER_OUTPUT: 20:04:41 INFO - 2015-12-16 20:04:41,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52060/tests/kraken/driver.html?testName=audio-oscillator) 20:04:41 INFO - 2015-12-16 20:04:41,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 157028352 20:04:41 INFO - 2015-12-16 20:04:41,903 DEBUG : BROWSER_OUTPUT: 20:04:44 INFO - 2015-12-16 20:04:44,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:04:44 INFO - 2015-12-16 20:04:44,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 158269440 20:04:44 INFO - 2015-12-16 20:04:44,678 DEBUG : BROWSER_OUTPUT: 20:04:47 INFO - 2015-12-16 20:04:47,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52060/tests/kraken/driver.html?testName=imaging-darkroom) 20:04:48 INFO - 2015-12-16 20:04:48,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 157413376 20:04:48 INFO - 2015-12-16 20:04:48,182 DEBUG : BROWSER_OUTPUT: 20:04:51 INFO - 2015-12-16 20:04:51,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52060/tests/kraken/driver.html?testName=imaging-desaturate) 20:04:52 INFO - 2015-12-16 20:04:52,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 158969856 20:04:52 INFO - 2015-12-16 20:04:52,121 DEBUG : BROWSER_OUTPUT: 20:04:54 INFO - 2015-12-16 20:04:54,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52060/tests/kraken/driver.html?testName=json-parse-financial) 20:04:55 INFO - 2015-12-16 20:04:55,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 158629888 20:04:55 INFO - 2015-12-16 20:04:55,411 DEBUG : BROWSER_OUTPUT: 20:04:56 INFO - 2015-12-16 20:04:56,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:04:57 INFO - 2015-12-16 20:04:57,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 167772160 20:04:57 INFO - 2015-12-16 20:04:57,532 DEBUG : BROWSER_OUTPUT: 20:04:59 INFO - 2015-12-16 20:04:59,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:04:59 INFO - 2015-12-16 20:04:59,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 167043072 20:04:59 INFO - 2015-12-16 20:04:59,926 DEBUG : BROWSER_OUTPUT: 20:05:01 INFO - 2015-12-16 20:05:01,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:05:02 INFO - 2015-12-16 20:05:02,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 175468544 20:05:02 INFO - 2015-12-16 20:05:02,563 DEBUG : BROWSER_OUTPUT: 20:05:04 INFO - 2015-12-16 20:05:04,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:05:05 INFO - 2015-12-16 20:05:05,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 186306560 20:05:05 INFO - 2015-12-16 20:05:05,571 DEBUG : BROWSER_OUTPUT: 20:05:08 INFO - 2015-12-16 20:05:08,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:05:08 INFO - 2015-12-16 20:05:08,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 182411264 20:05:08 INFO - 2015-12-16 20:05:08,714 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52060/tests/kraken/driver.html?testName=ai-astar) 20:05:10 INFO - 2015-12-16 20:05:10,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 241713152 20:05:10 INFO - 2015-12-16 20:05:10,634 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,635 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:10 INFO - 2015-12-16 20:05:10,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:10 INFO - 2015-12-16 20:05:10,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;103;109;109;108;99;108;108;108 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;122;152;164;125;150;150;125;161;124 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;164;165;163;164;162;163;164;166;164 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;72;81;90;70;70;72;100;89;72 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;137;93;93;93;146;92;93;135 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;111;110;121;109;109;109;109 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;153;145;146;145;146;146;145;145;146 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;96;95;95;95;95 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;60;59;60;58;58;58;66;57;58 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;66;67;67;67;67;68;67;67 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;84;86;85;85;85;87;86;86 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;123;116;124;119;125;119;121;125 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;145;150;151;154;142;152;155;150;142 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;70;67;67;65;69;68;67;68 20:05:10 INFO - 2015-12-16 20:05:10,636 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:10 INFO - 2015-12-16 20:05:10,637 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:05:10 INFO - 2015-12-16 20:05:10,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 20:05:10 INFO - 2015-12-16 20:05:10,637 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:05:10 INFO - 2015-12-16 20:05:10,637 DEBUG : BROWSER_OUTPUT: __startTimestamp1450325110634__endTimestamp 20:05:10 INFO - 2015-12-16 20:05:10,637 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,638 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:10 INFO - 2015-12-16 20:05:10,638 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:05:10 INFO - 2015-12-16 20:05:10,638 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,638 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:108.50 stddev:3.48 (3.2%) stddev-sans-first:3.67 20:05:10 INFO - 2015-12-16 20:05:10,638 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 103.0 109.0 109.0 108.0 99.0 108.0 108.0 108.0 20:05:10 INFO - 2015-12-16 20:05:10,638 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,638 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:150.00 stddev:16.41 (10.9%) stddev-sans-first:17.22 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: Values: 149.0 122.0 152.0 164.0 125.0 150.0 150.0 125.0 161.0 124.0 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: Values: 165.0 164.0 165.0 163.0 164.0 162.0 163.0 164.0 166.0 164.0 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:72.00 stddev:10.82 (15.0%) stddev-sans-first:11.02 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 81.0 90.0 70.0 70.0 72.0 100.0 89.0 72.0 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.62 (24.3%) stddev-sans-first:23.44 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 137.0 93.0 93.0 93.0 146.0 92.0 93.0 135.0 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,639 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:109.00 stddev:3.75 (3.4%) stddev-sans-first:3.94 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 111.0 110.0 121.0 109.0 109.0 109.0 109.0 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:2.44 (1.7%) stddev-sans-first:2.55 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: Values: 145.0 153.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.50 stddev:2.79 (4.7%) stddev-sans-first:2.69 20:05:10 INFO - 2015-12-16 20:05:10,640 DEBUG : BROWSER_OUTPUT: Values: 63.0 60.0 59.0 60.0 58.0 58.0 58.0 66.0 57.0 58.0 20:05:10 INFO - 2015-12-16 20:05:10,641 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,641 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 20:05:10 INFO - 2015-12-16 20:05:10,641 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 20:05:10 INFO - 2015-12-16 20:05:10,641 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,641 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:0.88 20:05:10 INFO - 2015-12-16 20:05:10,641 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 84.0 86.0 85.0 85.0 85.0 87.0 86.0 86.0 20:05:10 INFO - 2015-12-16 20:05:10,641 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:123.00 stddev:2.95 (2.4%) stddev-sans-first:3.09 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 123.0 116.0 124.0 119.0 125.0 119.0 121.0 125.0 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:150.50 stddev:4.77 (3.2%) stddev-sans-first:4.87 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 150.0 151.0 154.0 142.0 152.0 155.0 150.0 142.0 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.43 (2.1%) stddev-sans-first:1.51 20:05:10 INFO - 2015-12-16 20:05:10,642 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 70.0 67.0 67.0 65.0 69.0 68.0 67.0 68.0 20:05:10 INFO - 2015-12-16 20:05:10,643 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:10 INFO - 2015-12-16 20:05:10,643 DEBUG : BROWSER_OUTPUT: 20:05:11 INFO - 2015-12-16 20:05:11,549 INFO : Browser exited with error code: 0 20:05:11 INFO - 2015-12-16 20:05:11,604 INFO : Completed test kraken (00:00:59) 20:05:11 INFO - 2015-12-16 20:05:11,604 INFO : Starting test v8_7 20:05:11 INFO - 2015-12-16 20:05:11,604 DEBUG : operating with platform_type : linux_ 20:05:11 INFO - 2015-12-16 20:05:11,604 INFO : Initialising browser for v8_7 test... 20:05:11 INFO - 2015-12-16 20:05:11,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCKZOl9/profile http://localhost:52060/getInfo.html 20:05:15 INFO - 2015-12-16 20:05:15,659 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:05:15 INFO - 2015-12-16 20:05:15,659 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:05:15 INFO - 2015-12-16 20:05:15,660 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:05:15 INFO - 2015-12-16 20:05:15,660 DEBUG : BROWSER_OUTPUT: __metrics 20:05:15 INFO - 2015-12-16 20:05:15,776 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] 20:05:15 INFO - 2015-12-16 20:05:15,832 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] 20:05:17 INFO - 2015-12-16 20:05:17,130 INFO : Browser initialized. 20:05:17 INFO - 2015-12-16 20:05:17,131 INFO : Running cycle 1/1 for v8_7 test... 20:05:17 INFO - 2015-12-16 20:05:17,131 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCKZOl9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:05:28 INFO - 2015-12-16 20:05:28,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 142827520 20:05:28 INFO - 2015-12-16 20:05:28,946 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52060/tests/v8_7/run.html (next: http://localhost:52060/tests/v8_7/run.html) 20:05:50 INFO - 2015-12-16 20:05:50,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 603680768 20:05:50 INFO - 2015-12-16 20:05:50,593 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,593 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:50 INFO - 2015-12-16 20:05:50,593 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |0;Richards;166.05778811026238 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.39487565938205 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2032.520325203252 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |7;RegExp;25717.94871794872 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |8;Splay;682.0966643975494 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: __startTimestamp1450325150587__endTimestamp 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:50 INFO - 2015-12-16 20:05:50,595 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:05:50 INFO - 2015-12-16 20:05:50,595 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,595 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,595 DEBUG : BROWSER_OUTPUT: Values: 166.1 20:05:50 INFO - 2015-12-16 20:05:50,595 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,595 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,595 DEBUG : BROWSER_OUTPUT: Values: 188.4 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: Values: 279.3 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: Values: 5128.2 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: Values: 2032.5 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,596 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: Values: 787.4 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: Values: 12096.4 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: Values: 25717.9 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:682.10 Median:682.10 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: Values: 682.1 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: Values: 4830.9 20:05:50 INFO - 2015-12-16 20:05:50,597 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:50 INFO - 2015-12-16 20:05:50,598 DEBUG : BROWSER_OUTPUT: 20:05:51 INFO - 2015-12-16 20:05:51,413 INFO : Browser exited with error code: 0 20:05:51 INFO - 2015-12-16 20:05:51,425 INFO : Completed test v8_7 (00:00:39) 20:05:51 INFO - 2015-12-16 20:05:51,598 INFO : Completed test suite (00:20:12) 20:05:51 INFO - 2015-12-16 20:05:51,598 DEBUG : Working with test: dromaeo_css 20:05:51 INFO - 2015-12-16 20:05:51,599 DEBUG : Generating results file: dromaeo_css 20:05:51 INFO - 2015-12-16 20:05:51,600 DEBUG : Working with test: kraken 20:05:51 INFO - 2015-12-16 20:05:51,600 DEBUG : Generating results file: kraken 20:05:51 INFO - 2015-12-16 20:05:51,600 INFO : javascript benchmark 20:05:51 INFO - 2015-12-16 20:05:51,600 DEBUG : Working with test: v8_7 20:05:51 INFO - 2015-12-16 20:05:51,600 DEBUG : Generating results file: v8_7 20:05:51 INFO - 2015-12-16 20:05:51,601 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:51 INFO - 2015-12-16 20:05:51,659 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:05:51 INFO - 2015-12-16 20:05:51,659 DEBUG : process_Request line: dromaeo_css 6880.31 graph.html#tests=[[72,64,35]] 20:05:51 INFO - 2015-12-16 20:05:51,659 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:51 INFO - 2015-12-16 20:05:51,693 DEBUG : process_Request line: kraken 1500.40 graph.html#tests=[[232,64,35]] 20:05:51 INFO - 2015-12-16 20:05:51,693 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:05:51 INFO - 2015-12-16 20:05:51,728 DEBUG : process_Request line: v8_7 19622.19 graph.html#tests=[[230,64,35]] 20:05:51 INFO - 2015-12-16 20:05:51,729 INFO : javascript benchmark 20:05:51 INFO - 2015-12-16 20:05:51,733 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3149.385869755398, 3185.1877771168347, 3199.6960288772575, 3223.7904536205147, 3249.41510528105, 5180.197069454241, 5261.447548007452, 5315.68105913645, 5357.973210133949, 5450.209719590657, 5261.86845328867, 5318.388385335687, 5340.759665815038, 5408.756605952732, 5451.563874890009, 4934.531219534148, 4935.087008903364, 4969.950300497003, 4986.501349865002, 5089.541941225289, 4967.627427942901, 5090.109230884599, 5094.46508116648, 5113.156329205676, 5113.5909127269915, 4715.481297057321, 4812.951870481285, 4842.975785121052, 4973.701577905337, 5038.748062596874, 4988.476209997971, 4999.600031997432, 5001.724905130216, 5001.9499805002215, 5050.924236136461, 4951.084049450863, 4958.7024778513405, 4964.8758781030765, 4970.453250142481, 4986.476419975923, 5085.338905942241, 5127.384713834326, 5186.196139598331, 5203.843884683465, 5205.349331333583, 5770.394108618577, 5806.82579522615, 5814.796482123105, 5815.476607105338, 5818.185454036438, 5744.569157313218, 5810.099434587646, 5908.645481271137, 5915.526757859361, 5917.319508256563, 5267.736613169364, 5307.336582927134, 5348.197770334481, 5477.972610136963, 5490.6431081979545, 5898.793542226087, 5909.2908850938165, 5911.793087241926, 5919.4968427684125, 5923.348431672513, 5431.945680543223, 5754.136879468113, 5755.251817263729, 5755.59710820247, 5766.567507436959, 5733.799317023968, 5782.479576838021, 5819.563532735062, 5915.260592425947, 5927.377625349276, 5814.941850581525, 5823.650580965155, 5847.8245652630485, 5851.268591426072, 5851.590388672752, 5853.356130825606, 5858.47273745365, 5864.794732184353, 5870.090136028923, 5871.7651293947765, 4356.738595684269, 4412.051408947092, 4433.069055498381, 4494.977525112354, 4501.504834468205, 3984.382420724792, 3984.7011474139554, 4005.0, 4019.21625283067, 4051.7366371186367, 5510.1459273812625, 5547.417521160301, 5563.082091454946, 5565.2191298784, 5609.887802243932, 5725.914111288334, 5781.884362312814, 5855.736491857877, 5857.531397488191, 5858.882822343615, 5493.670379777226, 5529.751161197756, 5560.082586373284, 5561.054620714407, 5564.554835613141, 4949.752512374439, 4959.628027897922, 4959.925601115986, 4966.925496117489, 5001.1498045331655, 5852.502537284294, 5942.0, 6013.939860601426, 6032.607880487754, 6039.063945088518, 5816.098504731774, 5823.126531020381, 5888.499477544457, 5900.0, 5947.10793380979, 5907.881842363215, 5915.792947246826, 5916.0, 5917.644941303363, 5921.851953701192, 5561.499465048165, 5626.099824028136, 5684.431556844283, 5736.42635736423, 5745.597808153389, 5734.971325143348, 5844.590878638454, 5956.047032474957, 5966.0454327307425, 5967.582269241111, 5817.912731308949, 5831.679257640871, 5831.708414579339, 5832.62087964281, 5835.416458354131, 5554.361248456317, 5661.745221464962, 5780.364159942487, 5798.797042103506, 5800.100984347433, 5517.69652669107, 5575.8884822304135, 5577.637453565505, 5596.0206963780365, 5620.072688006597, 5735.426457354231, 5741.282339707536, 5751.913721294268, 5753.884922301447, 5817.360090389969, 5391.460853914734, 5448.4006759257245, 5541.861453463695, 5585.5252303553025, 5589.496945274782], "unit": "score", "name": "dojo.html", "value": 5359.670216511379}, {"lowerIsBetter": false, "replicates": [555.8211809705953, 594.2720167794452, 602.5089552015107, 604.9122877182807, 618.5608218165108, 27929.860350698244, 38425.80787096064, 39471.99999999996, 39492.210155796936, 39550.40674389879, 42484.36273455901, 43051.0, 43090.569094309045, 43132.56867431325, 43152.784236078776, 7579.279968403021, 7711.5758633275145, 7714.768556943301, 8724.869126963085, 8898.466092034467, 7680.116786569532, 10458.686239412791, 10632.681019569425, 10685.519151638195, 10690.518926648281, 10370.585176592966, 10403.687889363331, 10456.895431045668, 10469.267151299413, 10484.213683973694, 7834.921650783476, 8010.639521221559, 10355.275130740814, 10470.0, 10471.947640261826, 10509.947450262776, 10761.08530774885, 10768.3538987661, 10771.56913723458, 10783.730406739895, 40262.194756105004, 40270.19459610791, 40544.79727601343, 40589.59410405887, 40724.59275407238, 3309.4373956427467, 3310.420676381648, 3339.716124129452, 3340.1482621931495, 3350.8659653613827, 30164.396712065856, 30183.849080754677, 30297.091087267418, 30674.846625766728, 30715.232119196975, 3468.6052880545685, 3473.7915725056578, 3518.1204698825295, 3540.1149712571855, 3632.7275454340765, 274971.0, 275098.0, 275235.6238218816, 275913.0, 276669.0, 54477.0, 55397.0, 55978.0, 56946.43053569494, 57179.71410142923, 56007.0, 56135.43864561384, 56231.71884140635, 56492.717536412056, 56692.71653641705, 13286.800697989538, 13377.933110334387, 13396.26320552379, 13401.396937137852, 13562.728745425036, 10272.640457584099, 10274.589016439408, 10281.897181028244, 10360.720641458867, 10389.53247103867, 18773.530661733566, 18794.53013674669, 18904.243830246636, 18912.527186820163, 19063.90468047651, 7241.0, 7480.625968701544, 7543.547387156788, 7592.81017974555, 7598.278163574451, 927.3554879358916, 941.8775559177263, 984.9852252216223, 1031.4997226345217, 1103.9558417663204, 28480.572791408147, 28754.424911501654, 28965.275868103465, 29126.0, 29374.559381608866, 960.2345245692501, 1034.7051090439188, 1070.550368845087, 1123.3996783173056, 1174.864890537582, 15137.697246055017, 15150.924245378923, 15221.31504082319, 15324.616884577974, 15389.384424623113, 321110.0, 325022.0, 326031.0, 326225.0, 328025.0, 51953.220701689504, 52052.739736301075, 52206.0, 52207.0, 52253.7387313061, 1278.8337516122845, 1301.1477482249143, 1303.5958852755675, 1304.230504002643, 1314.769915264825, 27368.863155684096, 28364.290892727848, 28566.85716571487, 28634.57048144321, 28868.711312886604, 45737.0, 46039.76980115078, 46076.0, 46090.308645369674, 46133.538664614265, 298566.0, 298604.0, 299201.0, 299906.0, 300280.0, 27194.592081119194, 30269.0, 30613.387732244784, 30720.0, 30979.225519362197, 36792.63207367892, 37369.813150934075, 37872.62127378801, 37927.0, 41209.38185927153, 35042.824785875906, 35106.82446587751, 35237.11907202341, 35342.82328588341, 36044.27911441809, 29406.0, 31984.0, 33736.49395259024, 34895.0, 35225.0, 34075.488867667504, 34409.48385774165, 34550.30899381948, 34897.65102348944, 34900.301993959474, 31228.687713122577, 32458.83770581132, 32502.34995300128, 32506.0, 32612.83693581517, 24528.0, 24674.13640522573, 24770.876145619877, 24950.50098998046, 25170.74829251684], "unit": "score", "name": "ext.html", "value": 18338.152641192923}, {"lowerIsBetter": false, "replicates": [359.05031192495846, 359.36930686644945, 359.7426992660653, 359.94240921452564, 362.69352397224367, 13615.45538178474, 13622.569630188837, 16310.836891631096, 16554.337826486943, 17227.483175504738, 11746.7650646987, 12086.21439606425, 14117.223552704598, 14134.0, 14439.422423103064, 5364.409914909366, 5507.972460137694, 5508.531774799127, 5508.889822203553, 5511.035568775468, 3921.8235179416993, 4019.738716983387, 5320.6275560710765, 5406.83779486616, 5437.619366644337, 5754.971225143869, 5856.297244330686, 5897.351291357947, 5900.940990590082, 5902.675352855591, 5400.945990540084, 5411.269478620376, 5589.273394458714, 5849.736761845727, 5875.618084824473, 5090.33825602673, 5157.329547158883, 5164.896702065976, 5166.819161329373, 5168.689878607295, 20383.286584969603, 20397.184112635627, 20699.379018629315, 20719.58560828775, 20723.896380518, 1953.667876461005, 2326.627739561662, 2386.343755467243, 2399.484110916144, 2490.750924907513, 9450.149486546245, 9669.516524173763, 9681.419114853132, 9830.803383932353, 9930.851037234448, 1801.8018018017997, 1830.2495976649643, 1862.4319582527323, 1866.4680566038614, 1881.106474424651, 56117.43882561204, 56478.152827707614, 56651.71674141644, 57246.713766430905, 61746.69126654383, 9488.95255523718, 9773.609055637695, 9796.26528010402, 9802.264830137769, 9818.116369526777, 12987.805182922264, 13080.476780928657, 13117.0, 13127.0, 13132.015098867623, 7118.71525138999, 7149.964250178716, 7161.67772450241, 7180.281971802778, 7205.603691796897, 6812.4550035997, 6825.283345248777, 6828.00993855898, 6830.180378354629, 6841.486888483384, 4269.338252570857, 4302.3546468030045, 4313.396124542566, 4342.109867477159, 4346.239408103569, 1638.0744879143247, 1679.41220572801, 1767.8585713142918, 1793.6950718377907, 1795.1921635264184, 409.0673264955905, 413.5492313378432, 428.4323271664994, 954.0364232125603, 1006.6476733143488, 10004.299699021145, 10757.354558726502, 10796.67609971702, 10833.29583577065, 10930.0, 419.9622034016953, 423.9152169566099, 425.8105143211303, 446.15899030328063, 447.4786873292643, 5351.946480535223, 5946.43508866657, 5995.430434108753, 6005.279366475964, 6013.1581578579035, 540874.0, 544778.0, 556520.0, 559565.0, 571009.0, 72132.0, 72180.94438176889, 81248.18751812406, 84331.5783421079, 85126.57436712777, 1132.105636547135, 1137.852079229695, 1167.095500986725, 1193.964181074569, 1197.9341136237417, 15917.602059948595, 16038.518844434686, 16211.756823647891, 16221.918890405472, 16245.756313655542, 34865.12837178989, 35173.47239791354, 35394.46908296429, 35858.0, 36465.453018204214, 45637.77181114073, 48094.75952620214, 48632.270515943, 48915.0, 52515.0, 9116.726498205064, 9329.440233585736, 9411.058894110534, 9417.199538039344, 9585.520723963635, 11523.308601483937, 11562.248453850472, 11674.883251167379, 12599.43302551369, 17549.561260968578, 11023.0, 13401.32993350348, 13420.060595758594, 13454.596362109152, 13504.527341543391, 14074.995379596958, 14206.21865797391, 14557.27213639335, 14566.635834104232, 14595.416183352547, 10998.615048473264, 13805.51680691171, 14194.077384969944, 14297.0, 15405.306761195548, 9489.762755931157, 9508.952455237679, 9582.377145485521, 9597.856032159663, 9608.855867162138, 9871.50642467888, 9948.054934781185, 10905.0, 14653.70692586121, 15115.395384184509], "unit": "score", "name": "jquery.html", "value": 8169.045365799833}, {"lowerIsBetter": false, "replicates": [1337.1776357540116, 1438.5756201920433, 1495.7905893174955, 1611.677664467107, 1737.2877120380647, 6395.104685344056, 7220.711171553138, 7351.4486413519, 7357.705691772323, 7360.2271761464945, 7410.147832999207, 7572.091349038109, 7577.204393538682, 7581.469297149201, 7596.734114306, 1955.5795503966644, 2008.1866843928233, 2218.0, 2228.621134407155, 2257.7177852768405, 2268.9546209075806, 2269.375921621551, 2269.8524595901295, 2271.65925111233, 2272.7954484096426, 2210.370044537307, 2257.4356410897276, 2260.5930932432157, 2260.9660855087186, 2263.094762095167, 2222.9110835566557, 2244.921427750029, 2258.4128126687015, 2261.9886900565557, 2275.613145765224, 2248.4154119928935, 2264.9886750566307, 2272.1479445208047, 2293.3693234360517, 2297.4371279036577, 7579.696812127509, 7648.120466146409, 7664.7317343893255, 7673.46285759997, 7678.040244969379, 4408.448943882015, 4436.134953684033, 4466.598006179427, 4505.098980203939, 4510.0, 2942.9705702943124, 3015.366772977677, 3052.786304958654, 3053.0, 3064.1420402287395, 996.8056229035341, 998.0, 1013.5084484025242, 1027.9537420816082, 1028.2134167361974, 10231.744206394826, 10243.79512409755, 10246.436445995467, 10258.692239232834, 10262.589496420134, 4227.217964676544, 4261.978690106592, 4325.502567204749, 4330.610245077895, 4330.913381732411, 8873.068327825486, 8882.733517994471, 8882.822343553093, 8886.822263554694, 8892.73321800347, 4537.659675524283, 4538.977305113453, 4584.243599805995, 4585.656075794329, 4593.0, 4127.8968025798995, 4128.896777580585, 4129.97935010323, 4130.277201489727, 4131.855385061508, 3289.588801399825, 3303.785253958485, 3342.615599206074, 3439.1402149462633, 3529.3294274087843, 1147.1854982962022, 1168.9590864319707, 1169.2516789254885, 1191.7199458127334, 1191.9582814601447, 1063.4416931111073, 1064.180580952662, 1096.1395304685784, 1210.7094297368744, 1343.8253027106414, 7162.068931039036, 7238.0, 7247.565146091251, 7249.130104387507, 7350.33846953766, 1023.3450591621369, 1032.2516175772505, 1035.8756949166147, 1039.7452624107143, 1133.631569739838, 5774.335951365562, 5815.098659707752, 5852.15143804146, 5860.062390017577, 5873.706314684334, 8998.55007249635, 9248.815023699623, 9300.767480812898, 9312.255019598417, 9320.207782338577, 8864.778380540409, 9016.233620142362, 9063.501507417024, 9194.356395052282, 9212.631494740135, 6908.585484870823, 6946.930530694831, 6948.0, 6949.061876646588, 6956.79129626112, 6931.89602155958, 7001.0, 7023.297670232936, 7030.894536582057, 7033.824154395977, 7832.569208693577, 8115.634796434293, 8202.876956845532, 8228.794280143044, 8259.21537453941, 8029.156938521604, 8179.018517777905, 8348.248657620843, 8363.289120424832, 8363.49819010837, 6223.284322302993, 6339.778107766206, 6345.746170153327, 6346.174997250328, 6347.619142851259, 6569.835754106186, 6652.201735791736, 7039.859202815813, 7126.180489243803, 7460.104787425326, 6755.695993680394, 6864.759733409506, 6907.758228461979, 7019.964900175671, 7040.119985001875, 6776.93223067763, 6804.795856124324, 6820.35206655367, 6895.862082758417, 6951.617661028489, 6888.070110535014, 6914.0, 6919.619420931897, 6924.93075069263, 6927.376536111774, 6178.876422471435, 6199.969000155151, 6210.875782484415, 6401.199850018747, 6455.128557644845, 6513.348665133449, 6529.281779004401, 6531.314212007861, 6542.280349161493, 6543.411093001652], "unit": "score", "name": "mootools.html", "value": 4373.658654813675}, {"lowerIsBetter": false, "replicates": [319.0428713858425, 321.8776864791379, 323.9287356781507, 328.77643202622215, 328.829008915364, 5870.765169393219, 5986.910196347058, 5987.161797348369, 6009.489193418559, 6030.306514750805, 5786.913196302059, 5891.204687367204, 5906.37983011784, 5927.970360148193, 5929.2884853817495, 4628.791704373311, 4634.930476042862, 4635.559621835929, 4636.97681511592, 4645.792094055536, 4413.360062790894, 4518.938049558351, 4521.186186486431, 4605.30920361945, 4645.0, 4538.546145385468, 4539.7957091930775, 4540.18276710192, 4546.727196368212, 4560.293154561032, 4550.658700597452, 4555.157295900269, 4560.156371071363, 4566.06395688883, 4568.428946381702, 3978.562358140602, 3981.5620281768984, 3984.7409918355215, 3989.364360612135, 4005.539362973237, 5572.3034620672415, 5667.5749318800845, 5675.886482270373, 5720.342160651495, 5734.569907256972, 5311.62818602698, 5319.494648008472, 5319.760610772524, 5320.65415747979, 5326.547243484309, 6036.396360363972, 6373.171487706569, 6378.776742814026, 6379.872402551923, 6383.840403989891, 4340.305551111838, 4354.499232588261, 4403.4495688039, 4411.6250118739945, 4414.470263568361, 6455.741770329181, 6558.376954189344, 6567.573107747981, 6570.868582628368, 6581.90127148098, 4493.460784705856, 4496.505384407713, 4498.302763071729, 4498.707584007029, 4500.482444518857, 4459.487158976694, 4547.2269714148015, 4549.3176023596725, 4552.112338094106, 4556.88607784808, 5262.684238945675, 5264.236685680631, 5267.71027593486, 5269.972355390739, 5282.339707536558, 6333.493320534346, 6378.489720822323, 6385.48916086712, 6391.0, 6399.072134540559, 1620.181808186858, 1632.037098112096, 1633.9918300408422, 1634.4687976407715, 1635.1987526112118, 1093.3822390349428, 1093.8577984861918, 1104.2215238257008, 1120.882307357732, 1128.0017184791518, 6126.571140020245, 6139.386061393825, 6141.017437210115, 6142.232220972379, 6154.076888466676, 6610.6694665267505, 6615.503837212228, 6618.735250590019, 6619.933800662028, 6620.172478440195, 5986.46121849027, 6132.264128304543, 6134.570580059353, 6139.324674285825, 6147.631142131487, 3567.839447224881, 3592.8023958682525, 3594.712423006153, 3595.7123430125525, 3598.514200582888, 6703.994400839913, 6720.6975686093265, 6723.462123030145, 6726.562773419712, 6731.326867313327, 6609.900851487231, 6741.426978706865, 6749.3250674932115, 6750.831229219309, 6760.763373281911, 6660.533762636665, 6667.699953502104, 6698.665066746643, 6706.0, 6710.188249172696, 6360.0, 6538.869222615616, 6584.374484423972, 6587.901181482377, 6589.6705164740615, 6446.4520515756685, 6448.032795080775, 6455.225372955276, 6463.15978922737, 6566.277709451861, 6747.831304217238, 6750.696218670269, 6758.560693554903, 6772.492063095189, 6775.49183811226, 4455.465344158722, 4538.954610453853, 4544.113897789899, 4544.818207271672, 4567.2007398705755, 6654.367835055662, 6655.0, 6655.467562595078, 6659.667016649051, 6664.200295964515, 6413.615183089029, 6472.352764723679, 6475.449586784987, 6475.805725828232, 6478.805635830932, 6298.0867774171575, 6389.68051597409, 6451.580647257913, 6461.19235095613, 6471.191101112361, 6345.682715864281, 6350.952092904804, 6351.047342898602, 6354.586951848115, 6358.809235722936, 6491.610503369813, 6498.350164983653, 6503.926852069356, 6504.869902601827, 6509.056186852785, 6075.574709770451, 6241.063840423791, 6267.811965641038, 6289.591176573508, 6294.087357333069], "unit": "score", "name": "prototype.html", "value": 4799.944954307065}, {"lowerIsBetter": false, "replicates": [743.788020414182, 756.5082696247439, 779.7076096463826, 782.0224719101121, 842.9241368276855, 13693.794593081111, 13991.0, 14001.929990350034, 14006.0, 14006.29968501576, 10648.254622176451, 13190.736185276288, 13200.0, 13220.669483262924, 13278.800817987738, 659.5877576514679, 801.3589128697048, 827.0612854410258, 830.8172202115525, 831.9725139452771, 822.5517093184229, 828.8922440082811, 831.2020460358063, 835.3943391041477, 836.6695155413609, 705.5272967112022, 710.985780284394, 862.5945805471418, 866.445474896067, 869.148234729965, 850.642730053376, 857.7855536115972, 864.0236532718051, 864.4078806017898, 864.8529749942494, 638.2851206648537, 639.7536948274948, 640.6572483721234, 640.8461969127376, 641.0864518061743, 13499.527516536973, 13664.93167534156, 13666.658333541642, 13690.452381904712, 13694.794578081337, 11899.0, 12171.026317894635, 12189.634310970596, 12684.365781710878, 12742.0, 9913.65302214419, 10073.949630251802, 10077.193824494023, 10122.595096196143, 10306.123979461754, 3619.8371073301764, 3631.346357655621, 3661.359262129143, 3752.9437058444146, 3757.7369584129124, 44257.33613995793, 44546.10907781859, 44562.77718611419, 44800.0, 44800.55199448029, 9679.274054445945, 9682.467464289392, 9707.611695532241, 9831.754206144904, 10058.245631577662, 18064.36774712879, 18069.7289540657, 18085.0, 18113.547161321072, 18128.728069078974, 7212.098487689039, 7316.597587132759, 7404.370628496638, 7462.701491940262, 7602.619869006528, 3988.501437320335, 4057.2494088593703, 4137.110521237948, 4145.419641250227, 4175.373693945871, 3001.294695746498, 3039.7264246217946, 3043.680413556545, 3062.892798752033, 3064.249258931576, 547.0672503381725, 550.1280470454295, 557.2115456628906, 570.5093619487237, 571.725571725574, 653.5752060508138, 653.6927644007309, 672.89570116632, 695.9269276725972, 700.3906601256939, 8517.74446766598, 8610.913890861011, 8664.436811607226, 8680.826383472295, 8836.690715824916, 567.8041075828914, 629.6033498895758, 694.9826254343682, 727.6761840980819, 728.1517032656895, 4285.785710714452, 4335.7181783184, 4370.409994650681, 4401.977990110029, 4457.618479718534, 53472.0, 53740.19389709157, 54147.0, 54154.458455415726, 60376.0, 47992.0, 48053.75973120112, 48387.75806120947, 48577.028459430614, 48983.265251021265, 42668.57331426708, 43539.782301088926, 43902.34146487805, 44816.3277550837, 45267.09465810665, 8227.506349619041, 8601.569921504026, 8699.608517616596, 8811.603477843384, 9025.277977761894, 33805.32389352249, 34119.48820767641, 35196.296074078884, 35366.0, 36814.63185368112, 42057.0, 42838.14323713571, 42878.35682464703, 43327.566724333614, 43802.34296485491, 10480.475976201313, 10798.244122911321, 10858.728531786768, 11089.0, 11101.777964440504, 12349.444275007467, 12376.75246495083, 12390.75218495607, 12467.0, 12551.05867059956, 11382.487788049391, 11703.769560809145, 11845.822312665145, 12035.819462707892, 12152.453139608562, 11529.711757206136, 11621.418929053345, 11739.882601173878, 12201.14591978553, 12335.629931102081, 8146.348292136497, 11175.88824111781, 11392.316461012366, 11453.770924581628, 11671.766564668489, 9887.357321774061, 10266.486675666038, 10341.63804266847, 10525.736856578647, 10526.78540447018, 9876.111149996535, 9974.800503990025, 9979.39329093102, 10076.84884726715, 10094.343867648578], "unit": "score", "name": "yui.html", "value": 6293.113168264873}], "name": "dromaeo_css", "value": 6880.31404311974}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 103.0, 109.0, 109.0, 108.0, 99.0, 108.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [149.0, 122.0, 152.0, 164.0, 125.0, 150.0, 150.0, 125.0, 161.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 165.0, 163.0, 164.0, 162.0, 163.0, 164.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 81.0, 90.0, 70.0, 70.0, 72.0, 100.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 137.0, 93.0, 93.0, 93.0, 146.0, 92.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 111.0, 110.0, 121.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [145.0, 153.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 59.0, 60.0, 58.0, 58.0, 58.0, 66.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 84.0, 86.0, 85.0, 85.0, 85.0, 87.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 123.0, 116.0, 124.0, 119.0, 125.0, 119.0, 121.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 150.0, 151.0, 154.0, 142.0, 152.0, 155.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 70.0, 67.0, 67.0, 65.0, 69.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1500.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [2032.520325203252], "unit": "score", "name": "RayTrace", "value": 364.0745880000001}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25717.94871794872], "unit": "score", "name": "RegExp", "value": 35.42214855433696}, {"lowerIsBetter": false, "replicates": [682.0966643975494], "unit": "score", "name": "Splay", "value": 119.47133632734533}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19622.186620453802}]} 20:05:51 INFO - RETURN: dromaeo_css: 6880.31 20:05:51 INFO - RETURN: kraken: 1500.40 20:05:51 INFO - RETURN: v8_7: 19622.19 20:05:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19622.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1500.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6880.31"}}} 20:05:51 INFO - Return code: 0 20:05:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:05:51 INFO - # TBPL SUCCESS # 20:05:51 INFO - Running post-action listener: _resource_record_post_action 20:05:51 INFO - Running post-run listener: _resource_record_post_run 20:05:52 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518729728; Read time: 12; Write time: 493876 20:05:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238317568; Read time: 0; Write time: 336664 20:05:52 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279982080; Read time: 12; Write time: 156700 20:05:52 INFO - Running post-run listener: _upload_blobber_files 20:05:52 INFO - Blob upload gear active. 20:05:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:05:52 INFO - Copying logs to upload dir... 20:05:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.719494 ========= master_lag: 51.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2015-12-16 20:06:44.232977) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 20:06:44.236541) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009970 build_url: 'https://queue.taskcluster.net/v1/task/dcBldwPyTMKLVrza36ZxRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.21 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 20:06:44.456389) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 20:06:44.456759) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450318074.394192-1044554181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 20:06:44.763631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 20:06:44.764309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 20:06:44.772699) ========= ========= Total master_lag: 52.09 =========