builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1452603830.16 results: success (0) buildid: 20160112023016 builduid: 1910835897344f09a7f0bc00538d2524 revision: 35c1ed58949d991030af52b8af23c879c8ccb364 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.162245) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.162753) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.163093) ========= 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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006361 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.195730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.196091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.211840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.213076) ========= 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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.268105) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.268476) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.268865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.269181) ========= 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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 05:03:51-- 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% 221M=0s 2016-01-12 05:03:51 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138791 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.520322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.520685) ========= 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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015386 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.656256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:50.656894) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 35c1ed58949d991030af52b8af23c879c8ccb364 --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 35c1ed58949d991030af52b8af23c879c8ccb364 --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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 05:03:52,245 truncating revision to first 12 chars 2016-01-12 05:03:52,245 Setting DEBUG logging. 2016-01-12 05:03:52,245 attempt 1/10 2016-01-12 05:03:52,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/35c1ed58949d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 05:03:52,610 unpacking tar archive at: fx-team-35c1ed58949d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658750 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.415036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.415441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.431290) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.431761) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 05:03:51.432697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-12 05:03:51.433035) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:53 INFO - MultiFileLogger online at 20160112 05:03:53 in /builds/slave/test-pgo 05:03:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:03:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:03:53 INFO - {'append_to_log': False, 05:03:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:03:53 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:03:53 INFO - 'branch': 'Fx-Team', 05:03:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:53 INFO - 'config_files': ('talos/linux_config.py',), 05:03:53 INFO - 'default_actions': ('clobber', 05:03:53 INFO - 'read-buildbot-config', 05:03:53 INFO - 'download-and-extract', 05:03:53 INFO - 'populate-webroot', 05:03:53 INFO - 'create-virtualenv', 05:03:53 INFO - 'install', 05:03:53 INFO - 'run-tests'), 05:03:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:53 INFO - 'download_minidump_stackwalk': True, 05:03:53 INFO - 'download_symbols': 'ondemand', 05:03:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:53 INFO - 'installer_path': 'installer.exe', 05:03:53 INFO - 'log_level': 'info', 05:03:53 INFO - 'log_name': 'talos', 05:03:53 INFO - 'log_to_console': True, 05:03:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:53 INFO - 'opt_config_files': (), 05:03:53 INFO - 'pip_index': False, 05:03:53 INFO - 'sps_profile': False, 05:03:53 INFO - 'sps_profile_interval': 0, 05:03:53 INFO - 'suite': 'dromaeojs-e10s', 05:03:53 INFO - 'system_bits': '32', 05:03:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:53 INFO - 'title': 'talos-linux64-ix-029', 05:03:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:53 INFO - 'use_talos_json': True, 05:03:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:03:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:53 INFO - 'work_dir': 'build'} 05:03:53 INFO - ##### 05:03:53 INFO - ##### Running clobber step. 05:03:53 INFO - ##### 05:03:53 INFO - Running pre-action listener: _resource_record_pre_action 05:03:53 INFO - Running main action method: clobber 05:03:53 INFO - rmtree: /builds/slave/test-pgo/build 05:03:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:03:53 INFO - Running post-action listener: _resource_record_post_action 05:03:53 INFO - ##### 05:03:53 INFO - ##### Running read-buildbot-config step. 05:03:53 INFO - ##### 05:03:53 INFO - Running pre-action listener: _resource_record_pre_action 05:03:53 INFO - Running main action method: read_buildbot_config 05:03:53 INFO - Using buildbot properties: 05:03:53 INFO - { 05:03:53 INFO - "project": "", 05:03:53 INFO - "product": "firefox", 05:03:53 INFO - "script_repo_revision": "production", 05:03:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:03:53 INFO - "repository": "", 05:03:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:03:53 INFO - "buildid": "20160112023016", 05:03:53 INFO - "pgo_build": "True", 05:03:53 INFO - "basedir": "/builds/slave/test-pgo", 05:03:53 INFO - "buildnumber": 124, 05:03:53 INFO - "slavename": "talos-linux64-ix-029", 05:03:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:03:53 INFO - "platform": "ubuntu64_hw", 05:03:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:03:53 INFO - "branch": "fx-team", 05:03:53 INFO - "repo_path": "integration/fx-team", 05:03:53 INFO - "revision": "35c1ed58949d991030af52b8af23c879c8ccb364", 05:03:53 INFO - "stage_platform": "linux64-pgo", 05:03:53 INFO - "builduid": "1910835897344f09a7f0bc00538d2524", 05:03:53 INFO - "slavebuilddir": "test" 05:03:53 INFO - } 05:03:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:03:53 INFO - Running post-action listener: _resource_record_post_action 05:03:53 INFO - ##### 05:03:53 INFO - ##### Running download-and-extract step. 05:03:53 INFO - ##### 05:03:53 INFO - Running pre-action listener: _resource_record_pre_action 05:03:53 INFO - Running main action method: download_and_extract 05:03:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:53 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json 05:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json 05:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:04:05 INFO - Downloaded 1302 bytes. 05:04:05 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:04:05 INFO - Using the following test package requirements: 05:04:05 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:05 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:04:05 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:05 INFO - u'jsshell-linux-x86_64.zip'], 05:04:05 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:04:05 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:05 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:04:05 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:04:05 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:04:05 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:05 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:04:05 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:05 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:16 INFO - Downloaded 24025081 bytes. 05:04:16 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 05:04:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:04:16 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 05:04:17 INFO - Return code: 0 05:04:17 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 05:04: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')]} 05:04:17 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:04:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:04:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:04:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:20 INFO - Downloaded 24025081 bytes. 05:04:20 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 05:04:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:04:20 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 05:04:22 INFO - Return code: 0 05:04:22 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')]} 05:04:22 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:04:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:24 INFO - Downloaded 11132285 bytes. 05:04:24 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 05:04:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:24 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 05:04:24 INFO - Return code: 0 05:04:24 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')]} 05:04:24 INFO - https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CKrssGa2Sk-0M8M39MBVag/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 05:04:32 INFO - Downloaded 55796332 bytes. 05:04:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:32 INFO - mkdir: /builds/slave/test-pgo/properties 05:04:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:04:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:04:32 INFO - Contents: 05:04:32 INFO - build_url:https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:04:32 INFO - Running post-action listener: _resource_record_post_action 05:04:32 INFO - Running post-action listener: set_extra_try_arguments 05:04:32 INFO - ##### 05:04:32 INFO - ##### Running populate-webroot step. 05:04:32 INFO - ##### 05:04:32 INFO - Running pre-action listener: _resource_record_pre_action 05:04:32 INFO - Running main action method: populate_webroot 05:04:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:32 INFO - '--tppagecycles', 05:04:32 INFO - '7'], 05:04:32 INFO - 'tests': ['tsvgm']}}, 05:04:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:04:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:04:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:04:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'tests': ['damp', 'tps']}, 05:04:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['damp', 'tps']}, 05:04:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:04:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:32 INFO - 'other': {'tests': ['a11yr', 05:04:32 INFO - 'ts_paint', 05:04:32 INFO - 'tpaint', 05:04:32 INFO - 'sessionrestore', 05:04:32 INFO - 'sessionrestore_no_auto_restore']}, 05:04:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['a11yr', 05:04:32 INFO - 'ts_paint', 05:04:32 INFO - 'tpaint', 05:04:32 INFO - 'sessionrestore', 05:04:32 INFO - 'sessionrestore_no_auto_restore']}, 05:04:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['a11yr', 05:04:32 INFO - 'ts_paint', 05:04:32 INFO - 'tpaint', 05:04:32 INFO - 'sessionrestore', 05:04:32 INFO - 'sessionrestore_no_auto_restore']}, 05:04:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['a11yr', 05:04:32 INFO - 'ts_paint', 05:04:32 INFO - 'tpaint', 05:04:32 INFO - 'sessionrestore', 05:04:32 INFO - 'sessionrestore_no_auto_restore']}, 05:04:32 INFO - 'other_l64': {'tests': ['a11yr', 05:04:32 INFO - 'ts_paint', 05:04:32 INFO - 'tpaint', 05:04:32 INFO - 'sessionrestore', 05:04:32 INFO - 'sessionrestore_no_auto_restore']}, 05:04:32 INFO - 'other_nol64': {'tests': ['a11yr', 05:04:32 INFO - 'ts_paint', 05:04:32 INFO - 'tpaint', 05:04:32 INFO - 'sessionrestore', 05:04:32 INFO - 'sessionrestore_no_auto_restore']}, 05:04:32 INFO - 'svgr': {'tests': ['tsvgx', 05:04:32 INFO - 'tsvgr_opacity', 05:04:32 INFO - 'tart', 05:04:32 INFO - 'tscrollx', 05:04:32 INFO - 'cart']}, 05:04:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['tsvgx', 05:04:32 INFO - 'tsvgr_opacity', 05:04:32 INFO - 'tart', 05:04:32 INFO - 'tscrollx', 05:04:32 INFO - 'cart']}, 05:04:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'tests': ['tp5o']}, 05:04:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'talos_options': ['--e10s'], 05:04:32 INFO - 'tests': ['tp5o']}, 05:04:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'talos_options': ['--xperf_path', 05:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:32 INFO - 'tests': ['tp5n']}, 05:04:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:32 INFO - 'talos_options': ['--e10s', 05:04:32 INFO - '--xperf_path', 05:04:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:32 INFO - 'tests': ['tp5n']}}, 05:04:32 INFO - 'talos.zip': {'path': '', 05:04:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:32 INFO - Running post-action listener: _resource_record_post_action 05:04:32 INFO - ##### 05:04:32 INFO - ##### Running create-virtualenv step. 05:04:32 INFO - ##### 05:04:32 INFO - Running pre-action listener: _resource_record_pre_action 05:04:32 INFO - Running main action method: create_virtualenv 05:04:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:04:32 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 05:04:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:04:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:32 INFO - Using real prefix '/usr' 05:04:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:04:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:34 INFO - Installing pip.................done. 05:04:34 INFO - Return code: 0 05:04:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:04:34 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')]} 05:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:34 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')]} 05:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:34 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:34 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 05:04:34 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 05:04:34 INFO - Using env: {'DISPLAY': ':0', 05:04:34 INFO - 'HOME': '/home/cltbld', 05:04:34 INFO - 'LANG': 'en_US.UTF-8', 05:04:34 INFO - 'LANGUAGE': 'en_US:en', 05:04:34 INFO - 'LOGNAME': 'cltbld', 05:04:34 INFO - 'MAIL': '/var/mail/cltbld', 05:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:34 INFO - 'MOZ_NO_REMOTE': '1', 05:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:34 INFO - 'NO_EM_RESTART': '1', 05:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:34 INFO - 'SHELL': '/bin/bash', 05:04:34 INFO - 'SHLVL': '1', 05:04:34 INFO - 'TERM': 'linux', 05:04:34 INFO - 'TMOUT': '86400', 05:04:34 INFO - 'USER': 'cltbld', 05:04:34 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:34 INFO - '_': '/tools/buildbot/bin/python'} 05:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:35 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 05:04:35 INFO - Cleaning up... 05:04:35 INFO - Return code: 0 05:04:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:35 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:35 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 05:04:35 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 05:04:35 INFO - Using env: {'DISPLAY': ':0', 05:04:35 INFO - 'HOME': '/home/cltbld', 05:04:35 INFO - 'LANG': 'en_US.UTF-8', 05:04:35 INFO - 'LANGUAGE': 'en_US:en', 05:04:35 INFO - 'LOGNAME': 'cltbld', 05:04:35 INFO - 'MAIL': '/var/mail/cltbld', 05:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:35 INFO - 'MOZ_NO_REMOTE': '1', 05:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:35 INFO - 'NO_EM_RESTART': '1', 05:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:35 INFO - 'SHELL': '/bin/bash', 05:04:35 INFO - 'SHLVL': '1', 05:04:35 INFO - 'TERM': 'linux', 05:04:35 INFO - 'TMOUT': '86400', 05:04:35 INFO - 'USER': 'cltbld', 05:04:35 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:35 INFO - '_': '/tools/buildbot/bin/python'} 05:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:35 INFO - Downloading/unpacking psutil>=0.7.1 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:35 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 05:04:36 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:04:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:04:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:37 INFO - Installing collected packages: psutil 05:04:37 INFO - Running setup.py install for psutil 05:04:37 INFO - building 'psutil._psutil_linux' extension 05:04:37 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 05:04:37 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 05:04:37 INFO - building 'psutil._psutil_posix' extension 05:04:37 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 05:04:37 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 05:04:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:37 INFO - Successfully installed psutil 05:04:37 INFO - Cleaning up... 05:04:37 INFO - Return code: 0 05:04:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:04: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')]} 05:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:37 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:37 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 05:04:37 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 05:04:37 INFO - Using env: {'DISPLAY': ':0', 05:04:37 INFO - 'HOME': '/home/cltbld', 05:04:37 INFO - 'LANG': 'en_US.UTF-8', 05:04:37 INFO - 'LANGUAGE': 'en_US:en', 05:04:37 INFO - 'LOGNAME': 'cltbld', 05:04:37 INFO - 'MAIL': '/var/mail/cltbld', 05:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:37 INFO - 'MOZ_NO_REMOTE': '1', 05:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:37 INFO - 'NO_EM_RESTART': '1', 05:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:37 INFO - 'SHELL': '/bin/bash', 05:04:37 INFO - 'SHLVL': '1', 05:04:37 INFO - 'TERM': 'linux', 05:04:37 INFO - 'TMOUT': '86400', 05:04:37 INFO - 'USER': 'cltbld', 05:04:37 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:37 INFO - '_': '/tools/buildbot/bin/python'} 05:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:04:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:04:39 INFO - Installing collected packages: mozsystemmonitor 05:04:39 INFO - Running setup.py install for mozsystemmonitor 05:04:39 INFO - Successfully installed mozsystemmonitor 05:04:39 INFO - Cleaning up... 05:04:39 INFO - Return code: 0 05:04:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:39 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:39 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 05:04:39 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 05:04:39 INFO - Using env: {'DISPLAY': ':0', 05:04:39 INFO - 'HOME': '/home/cltbld', 05:04:39 INFO - 'LANG': 'en_US.UTF-8', 05:04:39 INFO - 'LANGUAGE': 'en_US:en', 05:04:39 INFO - 'LOGNAME': 'cltbld', 05:04:39 INFO - 'MAIL': '/var/mail/cltbld', 05:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:39 INFO - 'MOZ_NO_REMOTE': '1', 05:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:39 INFO - 'NO_EM_RESTART': '1', 05:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:39 INFO - 'SHELL': '/bin/bash', 05:04:39 INFO - 'SHLVL': '1', 05:04:39 INFO - 'TERM': 'linux', 05:04:39 INFO - 'TMOUT': '86400', 05:04:39 INFO - 'USER': 'cltbld', 05:04:39 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:39 INFO - '_': '/tools/buildbot/bin/python'} 05:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:40 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 05:04:40 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 05:04:40 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 05:04:40 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 05:04:40 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 05:04:40 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 05:04:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:04:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:04:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:04:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:42 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 05:04:42 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 05:04:42 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 05:04:42 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 05:04:42 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 05:04:42 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 05:04:42 INFO - Downloading docopt-0.6.1.tar.gz 05:04:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:04:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:42 INFO - Running setup.py install for blobuploader 05:04:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:04:42 INFO - Running setup.py install for requests 05:04:43 INFO - Running setup.py install for docopt 05:04:43 INFO - Successfully installed blobuploader requests docopt 05:04:43 INFO - Cleaning up... 05:04:43 INFO - Return code: 0 05:04:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04: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')]} 05:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:43 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:43 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 05:04:43 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 05:04:43 INFO - Using env: {'DISPLAY': ':0', 05:04:43 INFO - 'HOME': '/home/cltbld', 05:04:43 INFO - 'LANG': 'en_US.UTF-8', 05:04:43 INFO - 'LANGUAGE': 'en_US:en', 05:04:43 INFO - 'LOGNAME': 'cltbld', 05:04:43 INFO - 'MAIL': '/var/mail/cltbld', 05:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:43 INFO - 'MOZ_NO_REMOTE': '1', 05:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:43 INFO - 'NO_EM_RESTART': '1', 05:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:43 INFO - 'SHELL': '/bin/bash', 05:04:43 INFO - 'SHLVL': '1', 05:04:43 INFO - 'TERM': 'linux', 05:04:43 INFO - 'TMOUT': '86400', 05:04:43 INFO - 'USER': 'cltbld', 05:04:43 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:43 INFO - '_': '/tools/buildbot/bin/python'} 05:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:43 INFO - Running setup.py (path:/tmp/pip-OlLWdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:43 INFO - Running setup.py (path:/tmp/pip-xaPcZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:43 INFO - Running setup.py (path:/tmp/pip-6vqqXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:43 INFO - Running setup.py (path:/tmp/pip-m4GRBC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:43 INFO - Running setup.py (path:/tmp/pip-MNuZoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:43 INFO - Running setup.py (path:/tmp/pip-Zn91bF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:43 INFO - Running setup.py (path:/tmp/pip-l6xEJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:43 INFO - Running setup.py (path:/tmp/pip-utP7Iu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:43 INFO - Running setup.py (path:/tmp/pip-x_NusV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:44 INFO - Running setup.py (path:/tmp/pip-pJJiQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:44 INFO - Running setup.py (path:/tmp/pip-RKGqNg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:44 INFO - Running setup.py (path:/tmp/pip-6feXuH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:44 INFO - Running setup.py (path:/tmp/pip-K9RFDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:44 INFO - Running setup.py (path:/tmp/pip-HLrkDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:44 INFO - Running setup.py (path:/tmp/pip-ux7oU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:44 INFO - Running setup.py (path:/tmp/pip-Y8Ox_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:44 INFO - Running setup.py (path:/tmp/pip-RNuvR3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:44 INFO - Running setup.py install for manifestparser 05:04:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:04:44 INFO - Running setup.py install for mozcrash 05:04:44 INFO - Running setup.py install for mozdebug 05:04:44 INFO - Running setup.py install for mozdevice 05:04:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Running setup.py install for mozfile 05:04:45 INFO - Running setup.py install for mozhttpd 05:04:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Running setup.py install for mozinfo 05:04:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Running setup.py install for mozInstall 05:04:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Running setup.py install for mozleak 05:04:45 INFO - Running setup.py install for mozlog 05:04:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Running setup.py install for moznetwork 05:04:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Running setup.py install for mozprocess 05:04:45 INFO - Running setup.py install for mozprofile 05:04:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:04:45 INFO - Running setup.py install for mozrunner 05:04:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:04:46 INFO - Running setup.py install for mozscreenshot 05:04:46 INFO - Running setup.py install for moztest 05:04:46 INFO - Running setup.py install for mozversion 05:04:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:04:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:46 INFO - Cleaning up... 05:04:46 INFO - Return code: 0 05:04:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04:46 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')]} 05:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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')]} 05:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:46 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:46 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 05:04:46 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 05:04:46 INFO - Using env: {'DISPLAY': ':0', 05:04:46 INFO - 'HOME': '/home/cltbld', 05:04:46 INFO - 'LANG': 'en_US.UTF-8', 05:04:46 INFO - 'LANGUAGE': 'en_US:en', 05:04:46 INFO - 'LOGNAME': 'cltbld', 05:04:46 INFO - 'MAIL': '/var/mail/cltbld', 05:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:46 INFO - 'MOZ_NO_REMOTE': '1', 05:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:46 INFO - 'NO_EM_RESTART': '1', 05:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:46 INFO - 'SHELL': '/bin/bash', 05:04:46 INFO - 'SHLVL': '1', 05:04:46 INFO - 'TERM': 'linux', 05:04:46 INFO - 'TMOUT': '86400', 05:04:46 INFO - 'USER': 'cltbld', 05:04:46 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:46 INFO - '_': '/tools/buildbot/bin/python'} 05:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:46 INFO - Running setup.py (path:/tmp/pip-Pl1dCt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:46 INFO - Running setup.py (path:/tmp/pip-c5FjSy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:46 INFO - Running setup.py (path:/tmp/pip-4hgidM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:46 INFO - Running setup.py (path:/tmp/pip-4UtrVY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:46 INFO - Running setup.py (path:/tmp/pip-cNP6RI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:46 INFO - Running setup.py (path:/tmp/pip-lOYWVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:47 INFO - Running setup.py (path:/tmp/pip-TibJXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:47 INFO - Running setup.py (path:/tmp/pip-Tk92e0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:47 INFO - Running setup.py (path:/tmp/pip-3QuFuY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:47 INFO - Running setup.py (path:/tmp/pip-YwskrJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:47 INFO - Running setup.py (path:/tmp/pip-WDVMMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:47 INFO - Running setup.py (path:/tmp/pip-F4uQAx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:47 INFO - Running setup.py (path:/tmp/pip-eiAEm4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:47 INFO - Running setup.py (path:/tmp/pip-ZvvNDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:47 INFO - Running setup.py (path:/tmp/pip-t46ssF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:47 INFO - Running setup.py (path:/tmp/pip-W3QkPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:47 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)) 05:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:47 INFO - Running setup.py (path:/tmp/pip-fNK_7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:47 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)) 05:04:47 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)) 05:04:47 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)) 05:04:47 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)) 05:04:47 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)) 05:04:47 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)) 05:04:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:47 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 05:04:47 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 05:04:47 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 05:04:47 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 05:04:47 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 05:04:47 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 05:04:49 INFO - Downloading blessings-1.5.1.tar.gz 05:04:49 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 05:04:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:49 INFO - Installing collected packages: blessings 05:04:49 INFO - Running setup.py install for blessings 05:04:49 INFO - Successfully installed blessings 05:04:49 INFO - Cleaning up... 05:04:49 INFO - Return code: 0 05:04:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:04:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:50 INFO - Reading from file tmpfile_stdout 05:04:50 INFO - Current package versions: 05:04:50 INFO - argparse == 1.2.1 05:04:50 INFO - blessings == 1.5.1 05:04:50 INFO - blobuploader == 1.2.4 05:04:50 INFO - docopt == 0.6.1 05:04:50 INFO - manifestparser == 1.1 05:04:50 INFO - mozInstall == 1.12 05:04:50 INFO - mozcrash == 0.16 05:04:50 INFO - mozdebug == 0.1 05:04:50 INFO - mozdevice == 0.47 05:04:50 INFO - mozfile == 1.2 05:04:50 INFO - mozhttpd == 0.7 05:04:50 INFO - mozinfo == 0.9 05:04:50 INFO - mozleak == 0.1 05:04:50 INFO - mozlog == 3.1 05:04:50 INFO - moznetwork == 0.27 05:04:50 INFO - mozprocess == 0.22 05:04:50 INFO - mozprofile == 0.28 05:04:50 INFO - mozrunner == 6.11 05:04:50 INFO - mozscreenshot == 0.1 05:04:50 INFO - mozsystemmonitor == 0.0 05:04:50 INFO - moztest == 0.7 05:04:50 INFO - mozversion == 1.4 05:04:50 INFO - psutil == 3.1.1 05:04:50 INFO - requests == 1.2.3 05:04:50 INFO - wsgiref == 0.1.2 05:04:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:50 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 05:04:50 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 05:04:50 INFO - Using env: {'DISPLAY': ':0', 05:04:50 INFO - 'HOME': '/home/cltbld', 05:04:50 INFO - 'LANG': 'en_US.UTF-8', 05:04:50 INFO - 'LANGUAGE': 'en_US:en', 05:04:50 INFO - 'LOGNAME': 'cltbld', 05:04:50 INFO - 'MAIL': '/var/mail/cltbld', 05:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:50 INFO - 'MOZ_NO_REMOTE': '1', 05:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:50 INFO - 'NO_EM_RESTART': '1', 05:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:50 INFO - 'SHELL': '/bin/bash', 05:04:50 INFO - 'SHLVL': '1', 05:04:50 INFO - 'TERM': 'linux', 05:04:50 INFO - 'TMOUT': '86400', 05:04:50 INFO - 'USER': 'cltbld', 05:04:50 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:50 INFO - '_': '/tools/buildbot/bin/python'} 05:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:04:50 INFO - Cleaning up... 05:04:50 INFO - Return code: 0 05:04:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:50 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 05:04:50 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 05:04:50 INFO - Using env: {'DISPLAY': ':0', 05:04:50 INFO - 'HOME': '/home/cltbld', 05:04:50 INFO - 'LANG': 'en_US.UTF-8', 05:04:50 INFO - 'LANGUAGE': 'en_US:en', 05:04:50 INFO - 'LOGNAME': 'cltbld', 05:04:50 INFO - 'MAIL': '/var/mail/cltbld', 05:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:50 INFO - 'MOZ_NO_REMOTE': '1', 05:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:50 INFO - 'NO_EM_RESTART': '1', 05:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:50 INFO - 'SHELL': '/bin/bash', 05:04:50 INFO - 'SHLVL': '1', 05:04:50 INFO - 'TERM': 'linux', 05:04:50 INFO - 'TMOUT': '86400', 05:04:50 INFO - 'USER': 'cltbld', 05:04:50 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:50 INFO - '_': '/tools/buildbot/bin/python'} 05:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:50 INFO - Downloading/unpacking jsonschema 05:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:52 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 05:04:52 INFO - Downloading/unpacking functools32 (from jsonschema) 05:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:52 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:04:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:52 INFO - warning: no files found matching '*.txt' 05:04:52 INFO - no previously-included directories found matching 'build' 05:04:52 INFO - no previously-included directories found matching 'dist' 05:04:52 INFO - no previously-included directories found matching '.git*' 05:04:52 INFO - Installing collected packages: jsonschema, functools32 05:04:52 INFO - Running setup.py install for functools32 05:04:52 INFO - warning: no files found matching '*.txt' 05:04:52 INFO - no previously-included directories found matching 'build' 05:04:52 INFO - no previously-included directories found matching 'dist' 05:04:52 INFO - no previously-included directories found matching '.git*' 05:04:52 INFO - Successfully installed jsonschema functools32 05:04:52 INFO - Cleaning up... 05:04:52 INFO - Return code: 0 05:04:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:04:52 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')]} 05:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:52 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')]} 05:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:52 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 0x7fcae8c78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, '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': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', '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 05:04:52 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 05:04:52 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 05:04:52 INFO - Using env: {'DISPLAY': ':0', 05:04:52 INFO - 'HOME': '/home/cltbld', 05:04:52 INFO - 'LANG': 'en_US.UTF-8', 05:04:52 INFO - 'LANGUAGE': 'en_US:en', 05:04:52 INFO - 'LOGNAME': 'cltbld', 05:04:52 INFO - 'MAIL': '/var/mail/cltbld', 05:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:52 INFO - 'MOZ_NO_REMOTE': '1', 05:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:52 INFO - 'NO_EM_RESTART': '1', 05:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:52 INFO - 'SHELL': '/bin/bash', 05:04:52 INFO - 'SHLVL': '1', 05:04:52 INFO - 'TERM': 'linux', 05:04:52 INFO - 'TMOUT': '86400', 05:04:52 INFO - 'USER': 'cltbld', 05:04:52 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:52 INFO - '_': '/tools/buildbot/bin/python'} 05:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:53 INFO - Downloading/unpacking flake8 05:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:04:54 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 05:04:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:04:55 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 05:04:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:55 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 05:04:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:04:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:55 INFO - no previously-included directories found matching 'docs/_build' 05:04:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:55 INFO - Running setup.py install for pep8 05:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:55 INFO - no previously-included directories found matching 'docs/_build' 05:04:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:04:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:55 INFO - Cleaning up... 05:04:55 INFO - Return code: 0 05:04:55 INFO - Running post-action listener: _resource_record_post_action 05:04:55 INFO - Running post-action listener: _start_resource_monitoring 05:04:55 INFO - Starting resource monitoring. 05:04:55 INFO - ##### 05:04:55 INFO - ##### Running install step. 05:04:55 INFO - ##### 05:04:55 INFO - Running pre-action listener: _resource_record_pre_action 05:04:55 INFO - Running main action method: install 05:04:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:55 INFO - Reading from file tmpfile_stdout 05:04:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:04:56 INFO - Reading from file tmpfile_stdout 05:04:56 INFO - Output received: 05:04:56 INFO - Usage: mozinstall [options] installer 05:04:56 INFO - Options: 05:04:56 INFO - -h, --help show this help message and exit 05:04:56 INFO - -d DEST, --destination=DEST 05:04:56 INFO - Directory to install application into. [default: 05:04:56 INFO - "/builds/slave/test-pgo"] 05:04:56 INFO - --app=APP Application being installed. [default: firefox] 05:04:56 INFO - mkdir: /builds/slave/test-pgo/build/application 05:04:56 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'] 05:04:56 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 05:05:12 INFO - Reading from file tmpfile_stdout 05:05:12 INFO - Output received: 05:05:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:05:12 INFO - Running post-action listener: _resource_record_post_action 05:05:12 INFO - ##### 05:05:12 INFO - ##### Running run-tests step. 05:05:12 INFO - ##### 05:05:12 INFO - Running pre-action listener: _resource_record_pre_action 05:05:12 INFO - Running main action method: run_tests 05:05:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:05:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:05:12 INFO - Python 2.7.3 05:05:12 INFO - Return code: 0 05:05:12 INFO - grabbing minidump binary from tooltool 05:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:12 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 0x1469660>, '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 0x146a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146aa10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:05:12 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 05:05:12 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 05:05:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:12 INFO - Return code: 0 05:05:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:05:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:05:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:05:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:05:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:05:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:05:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:05:13 INFO - Return code: 0 05:05:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:05:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:05:13 INFO - Using env: {'DISPLAY': ':0', 05:05:13 INFO - 'HOME': '/home/cltbld', 05:05:13 INFO - 'LANG': 'en_US.UTF-8', 05:05:13 INFO - 'LANGUAGE': 'en_US:en', 05:05:13 INFO - 'LOGNAME': 'cltbld', 05:05:13 INFO - 'MAIL': '/var/mail/cltbld', 05:05:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:05:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:13 INFO - 'MOZ_NO_REMOTE': '1', 05:05:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:13 INFO - 'NO_EM_RESTART': '1', 05:05:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:05:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:05:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:05:13 INFO - 'SHELL': '/bin/bash', 05:05:13 INFO - 'SHLVL': '1', 05:05:13 INFO - 'TERM': 'linux', 05:05:13 INFO - 'TMOUT': '86400', 05:05:13 INFO - 'USER': 'cltbld', 05:05:13 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291', 05:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:13 INFO - '_': '/tools/buildbot/bin/python'} 05:05:13 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:05:13 INFO - mozversion application_buildid: 20160112023016 05:05:13 INFO - mozversion application_changeset: 35c1ed58949d991030af52b8af23c879c8ccb364 05:05:13 INFO - mozversion application_display_name: Nightly 05:05:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:13 INFO - mozversion application_name: Firefox 05:05:13 INFO - mozversion application_remotingname: firefox 05:05:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:05:13 INFO - mozversion application_vendor: Mozilla 05:05:13 INFO - mozversion application_version: 46.0a1 05:05:13 INFO - mozversion platform_buildid: 20160112023016 05:05:13 INFO - mozversion platform_changeset: 35c1ed58949d991030af52b8af23c879c8ccb364 05:05:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:05:13 INFO - mozversion platform_version: 46.0a1 05:05:13 INFO - using testdate: 1452603913 05:05:13 INFO - actual date: 1452603913 05:05:13 INFO - starting webserver on 'localhost:44652' 05:05:13 INFO - SUITE-START | Running 3 tests 05:05:13 INFO - TEST-START | dromaeo_css 05:05:13 INFO - operating with platform_type : linux_ 05:05:13 INFO - Initialising browser for dromaeo_css test... 05:05:13 INFO - TEST-INFO | started process 22143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj74Nlw/profile http://localhost:44652/getInfo.html) 05:05:16 INFO - PROCESS | 22143 | 05:05:16 INFO - PROCESS | 22143 | (process:22230): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:05:17 INFO - PROCESS | 22143 | __metrics Screen width/height:1600/1200 05:05:17 INFO - PROCESS | 22143 | colorDepth:24 05:05:17 INFO - PROCESS | 22143 | Browser inner width/height: 1024/697 05:05:17 INFO - PROCESS | 22143 | __metrics 05:05:17 INFO - PROCESS | 22143 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:05:18 INFO - TEST-INFO | 22143: exit 0 05:05:18 INFO - Browser initialized. 05:05:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:18 INFO - TEST-INFO | started process 22279 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj74Nlw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:19 INFO - PROCESS | 22279 | 05:05:19 INFO - PROCESS | 22279 | (process:22337): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:05:30 INFO - PROCESS | 22279 | RSS: Main: 150949888 05:05:30 INFO - PROCESS | 22279 | 05:06:19 INFO - PROCESS | 22279 | 1452603979852 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] 05:08:28 INFO - PROCESS | 22279 | Cycle 1(1): loaded http://localhost:44652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44652/tests/dromaeo/cssquery-ext.html) 05:08:29 INFO - PROCESS | 22279 | RSS: Main: 157073408 05:08:29 INFO - PROCESS | 22279 | 05:11:31 INFO - PROCESS | 22279 | Cycle 1(1): loaded http://localhost:44652/tests/dromaeo/cssquery-ext.html (next: http://localhost:44652/tests/dromaeo/cssquery-jquery.html) 05:11:32 INFO - PROCESS | 22279 | RSS: Main: 152133632 05:11:32 INFO - PROCESS | 22279 | 05:14:34 INFO - PROCESS | 22279 | Cycle 1(1): loaded http://localhost:44652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44652/tests/dromaeo/cssquery-mootools.html) 05:14:34 INFO - PROCESS | 22279 | RSS: Main: 153395200 05:14:34 INFO - PROCESS | 22279 | 05:17:36 INFO - PROCESS | 22279 | Cycle 1(1): loaded http://localhost:44652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44652/tests/dromaeo/cssquery-prototype.html) 05:17:37 INFO - PROCESS | 22279 | RSS: Main: 149008384 05:17:37 INFO - PROCESS | 22279 | 05:20:39 INFO - PROCESS | 22279 | Cycle 1(1): loaded http://localhost:44652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44652/tests/dromaeo/cssquery-yui.html) 05:20:39 INFO - PROCESS | 22279 | RSS: Main: 151191552 05:20:39 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | Cycle 1(1): loaded http://localhost:44652/tests/dromaeo/cssquery-yui.html (next: http://localhost:44652/tests/dromaeo/cssquery-dojo.html) 05:23:42 INFO - PROCESS | 22279 | RSS: Main: 153567232 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | __start_tp_report 05:23:42 INFO - PROCESS | 22279 | _x_x_mozilla_page_load 05:23:42 INFO - PROCESS | 22279 | _x_x_mozilla_page_load_details 05:23:42 INFO - PROCESS | 22279 | |i|pagename|runs| 05:23:42 INFO - PROCESS | 22279 | |0;dojo.html;3238.206639373353;3261.59230096238;3296.8681252749893;3310.387578298016;3316.9004929852113;5306.257124002633;5380.058489764295;5383.057964856154;5389.811356602515;5389.868127693184;5319.069162896497;5416.052190866602;5450.264214331064;5509.311336082989;5522.502974732273;4552.567506086916;4896.706197628145;4993.400791904976;4995.025969935864;5020.121478741224;4835.371401717772;4970.801167953277;5049.4698056704065;5067.923981140286;5080.822171224008;4793.520647935214;4871;4876.756162191911;4878.878028049292;4890.902181956377;4913.041956818422;4917.582005529534;4924.433690125646;4947.158982972904;4956.677815941952;4817.084753896748;4897.33885925399;4897.6326775491625;4945.159322915113;4953.900921981576;5113.53978141969;5141.2545180948555;5193.740312984373;5300.257963885059;5361;5737.713114344266;5764.711764411804;5784.421557844224;5788.97105514474;5798.565107616945;5729.570282228808;5848.766049358021;5857.970710146465;5862.091375836752;5876.559258055663;5429.429909859447;5433.809816656398;5467.234587157801;5488.094464413367;5555.30558680165;5950.702464876739;5956.2852457704485;5971.5222782177325;5998.580099393001;6010.519158467312;5469.343678758495;5523.061079616395;5723;5749.338826035059;5756.942430575725;5838.737256823369;5888.057910734262;5906.911396329058;5918.615290006136;5966.880662386728;5791.5656325775735;5835.503982161479;5854.326752423526;5854.912176317359;5858.502027327725;5608.046632072476;5708.9714551427805;5856.502197313276;5883.617564858356;5887.234659494324;4474.821007159742;4540.88647783808;4544.772761361919;4578.9771051144535;4587.17430862448;4016.758994460342;4045.8786236412957;4055.59444055598;4061.289274376972;4098.282800509899;5405.081136206775;5423.864403389947;5481.479259470424;5485.286912701403;5521.585881058937;5811.680357580289;5847.152162936351;5864.237649105674;5880.088586269135;5889.293284805851;5467.425920278393;5467.5625949923915;5482.506574408322;5485.533729632946;5493.642913210629;4858.05267972742;4926.729029903389;4933.777979990909;4937.481564435754;5024.497550244946;6019.097135429721;6022.337542870281;6031.758729650853;6035.30593981689;6047.485963693048;5769.509591684754;5797.681127538026;5800.4489573490455;5815.127730840408;5816.127580862904;5963.671998040149;6020.909686354796;6071.51427885777;6095.922000763747;6127.662978536045;5697.401772813795;5699.088145896637;5699.287589051369;5700.2304688868135;5702.201691763239;5750.108733146369;5764.625299355528;5813.680247586423;5814.360420353673;5822.534197264124;5643.604947653789;5658.773649053992;5707.942920570741;5709;5751.74117164737;5690.630109042899;5693.572982026448;5714.028615135354;5715.685637289823;5736.598438109292;5563.527100196528;5603.5797315202335;5633.38032816398;5639.407862174413;5663.093904975184;5721.284839395075;5803.535717142703;5806.361300256884;5810.854728631818;5816.534677225896;5573.637713548606;5590.692511911884;5596.216529685766;5639.661620302795;5646.689432081275 05:23:42 INFO - PROCESS | 22279 | |1;ext.html;511.9820806271781;513.2890946039734;548.2160510470028;567.795593586309;575.712143928036;28127.718722812766;36679.449808252866;37196.25607487849;37417.43873841895;37534.62465375345;40398;40648.59351406485;40915;41075.79462102693;41153.79423102888;8463.4075614707;8566.271866891291;8684.739457816275;8685.044645089036;8697.695580654678;8407.621657025418;8440.57797110142;8448.11294814045;8479.236868681817;8528.232459078681;8472.83054338913;8538.44500107494;8543.14568543147;8546.359023073263;8566.271866891322;8446.113158118402;8518.78703032426;8559.01571319297;8758.693445729432;8776.034636190014;8457.281131103864;8559.27246184075;8572.957135214285;8574.528400937947;8713.346499012536;39697.80151099255;40354.79822600868;40420.595794041976;40531.79734101311;40595.391069133984;3329.267561136546;3480.4953281774;3487.686108250244;3769.4345848122725;3836.6163383661687;29676.406471870658;29794.702052979625;29849.25376865574;29998.400031999456;30909.072727817977;3887.766733995941;3943.960560394417;3956.9010774730864;4021.416894550303;4073.1446396256524;260344;260496;260919;261507.9999999981;261896;42824.57175428206;43191.568084319384;43216.56783432188;58027;58798.412015879294;43502.782486087366;43751.90620234456;43758;43784.562154378684;43878.7806060974;13856.93071534656;14067.085639433404;14206.786898196535;14227.430902763981;14239.430422782973;11890.28658280506;12136.635900922987;12235.816462753066;12243.632691019284;12247.632571022705;14409.42362305517;14582.19797911125;14590.489332873298;14659.780103298459;14682.926585367219;5716.599838011382;5723.713814309268;5752.453516915886;5770.990076736554;5813.151555737658;875.9693410730594;943.3585162089845;945.2485274207022;954.4464210757744;1013.2704452793977;26571.73428265731;27833;28298.2925426866;28311;28359.29101772472;1038.127972503101;1040.6461802986869;1047.2669131607904;1051.7580956379923;1106.231169337319;14429.838580789374;14790.630234244014;14856.405743770129;14871.33079011447;16387.83612163887;415483;417483;423885;423991;424167;55299;55414.44585554174;55788.44211557833;55825.44174558284;56078.15882761762;1333.5732565578921;1351.7837146056584;1356.2879488268738;1361.5779108476404;1366.6515038665077;29611.407771844013;30393.696063039086;30869.845650771604;30965.69034309628;31106;47171.764141179076;47408.52591474179;47517.287240690726;47703.28445073257;47770.28344574904;315043.3982640669;316519;317085;317389;318454;32168.195795104373;42348.15303693971;43025.78487107545;43808.561914381724;43824.56175438205;41196.17607647771;41874.79062604789;42107.789461052496;42656.57343426526;43244;36426.635733642324;36726;37235.06912327214;38568.26442810136;40142;35558.28883422369;36986.26027479489;37025.629743702215;37212.21084603448;37551.43672844964;36240.818795906904;36598.08504787295;36601.63398365982;38389.232215354976;38973.41539876961;29767.70232297736;31370.52944205793;33186.17034574155;33460.82504637191;33804.32391352209;25195.370115747253;25499.617505737056;25814.741852581235;26982.595261071492;27338.72661273362 05:23:42 INFO - PROCESS | 22279 | |2;jquery.html;353.9256756081223;357.78175313059046;357.892632210337;359.30115924526797;360.96751292383686;15952.76070858938;16040.438584649539;16685.58286042848;16962.575935601617;17740.82259177408;15008.399664013454;15106.546803595882;15489.302981365838;15494.380224791023;15516.612084697888;4705.106029854333;4885.462599114095;4889.706617602955;4891.046245982035;4893.755312234392;4372.841197082776;4743.454502732178;4766.666333356667;4883.974365383256;4890.046440944017;5020.046191223656;5054.823081192159;5055.368078990126;5256.710880901549;5273.839755253857;5188.429272779991;5210.322658054429;5229.973850130763;5499.175123731432;6002.339742628307;5261.552768014685;5272.367315922075;5279.44565820591;5281.735913204363;5305.867353316159;12090.758184836342;12903.67740806478;12935.935320323431;12954.417051232716;12976.416061277265;2002.909869055896;2050.4976280811147;2089.373188043596;2108.219958615307;2169.2190811307914;9210.401323913924;9277.814443711088;9490.240780737524;9725.0761177688;9752.317337786359;1759.9208035638428;1838.6966150585138;1841.6408800283816;1865.3564520240495;1870.1397357215697;54481.1827822583;55042.17436738412;55819;56607.71696141493;56897.43102569004;9497;9559.378640388491;9579.089986451276;9654.806903861883;9706.805863882682;12230.75538489243;12322.876771232173;12336.259824410565;12422.689432764073;12430.875691243153;7428.665710043061;7429.21993190718;7440.181580026193;7469.925300746923;7491.775246742606;7346.191918888918;7396.852062958711;7398.704051837866;7437.442191835634;7443.367313778282;4043.7978101094827;4121.670266378683;4122.196171746481;4155.709100362946;4260.062786187033;1669.3322670931725;1671.1477146655293;1707.8719096067844;1723.5518765120908;1726.7064599018197;452.8958339581849;456.56398139776434;468.5478513234745;967.7338731848798;1026.7330494071596;15515.767263491056;15515.767263491056;15860;16432.917835410986;16495.505134845975;918.2837386838277;931.6925414613162;938.9248860091176;946.9384490008127;957.5978089202551;9022;9058.230050445654;9191.080891910755;9225.49259790718;9475.478848663251;419422;424925;426785;428111;595682;38380.616193837704;38651.22697546033;42800.785996070445;47529.049419011426;62956.37043629597;1093.9398333091756;1135.7444574970566;1148.5520646947698;1148.626696323698;1149.218531398657;14324.427022918966;14353.569392918229;14400.855991439952;14635.85364146345;14654.56036318912;32211.67788322087;32755.672443275264;32907.50638740373;33013.50479742854;33356.833215833765;41349.79325103355;46440.767796160806;46565.068698626514;46711.76644116893;46940.53059469361;6887.6556172190185;7093.929060709327;7105.964470177616;7230.240824713329;7577.014988051738;10314;11508.59719909799;11522.596709115476;11594.6521604352;11821.822672659744;9020.774480638036;9406.905930940604;9893.01069893005;9959.153471954965;10121.240906931862;9578.664746733832;9864.802703946025;10133.138683211715;10273.9486302568;10428.322159059637;9640.951795240979;9982.500874956368;10023.298369114093;10293.330933489298;10308.175345972455;7143.607101609254;7260.709571617287;7344.70621175147;7462.216467270859;7538.698452061856;8246.958765206136;9729.318947673595;9901.86128595192;9904.207663387057;10052.894181639867 05:23:42 INFO - PROCESS | 22279 | |3;mootools.html;1451.2671101093947;1460.8027916231308;1604.5747876812648;1744.223820399921;1763.479773466827;7498.737544185955;7657.54054756715;7770;7814.179511151333;7864.921350786491;7839.294463498284;7877.291043806056;7955.840883182347;7975.361971042317;7981.361491080714;2404.8076153907646;2442.511497700458;2444.7555244475498;2446.0949448704005;2449.889754961022;2365.1485465232504;2418.383312255381;2418.600930846408;2420.4674971506242;2443.4502236996623;2333.8132949364094;2393.9162129325478;2408.0728919365997;2413.9275821725378;2428.3079322393123;2337;2355.8233132515043;2398.9160379386813;2401.4836810085826;2405.242348660184;2360.881955902198;2369.312899259213;2370.3007612754277;2373.7507561705943;2386.1052105460453;7472.364848987788;7514;7518.511296765692;7542.2834830691;7560.130584982742;4695.060987802419;4755.762211889391;4766.165920963817;4817.855464336076;4845.806167753286;3036.3320069584656;3109.3159504908886;3122.937541249185;3135.67075457076;3142.5443310720048;981.8183636027358;986.6300137448457;1007.425767312632;1007.5365331947313;1010.8534262531965;10778.353298802096;10818.08046316064;10865.83701244482;10871.67384978444;10897.291676041032;4334.761588112621;4461.598456138963;4512.729236245836;4550.135474259946;4591.862244132682;9463.952680236554;9477;9479.194268487256;9482.810343793086;9486.19367353769;4914.164592019365;4945.184044632667;4952.455229924705;4956.975215123901;4974.104661161025;4378.627816635558;4401.943533551988;4417.734935903856;4432.734035957853;4439.267520859022;3737.6822970047306;3766.3408903441787;3768.5289338832645;3792.544894612664;3816.637419445148;1139.5043156226902;1227.2145826670937;1263.1726219326356;1269.7143142792982;1274.8342715447118;1015.279151802214;1043.4521876015153;1045.7594753206654;1219.5243854896598;1357.7216670582507;7327.8534429312185;7386.965824784535;7399.4450416219;7412.407007439392;7427.554346739105;1029.7425643589104;1042.593388578455;1046.5290619221228;1061.310148403544;1148.1675785055934;5487.286652735119;5533.557315414757;5595.272614560081;5631.239782629293;5663.178839068312;9270.90729092714;9465.337426380225;9480.573374198178;9578.712638620713;9630.614775408905;8831.24934380572;9330.673426430178;9433.292503062297;9440.339176257596;9472.479013654178;7254.8911766323545;7324.707011719578;7373.152087510005;7406.444516661164;7412;7242.275772422716;7321.926780732125;7367.047732350824;7372.041634587469;7402.074740657418;8124.512529248264;8296.626651800563;8353.122922093336;8432.957835210786;8446.535440550828;8359.498430094214;8572.142785721378;8589.44168629037;8627.525486098324;8707.129287071495;6588.242352129567;6676.499262555425;6710.899336509859;6718.865622687421;6745.5952642841585;7176.461765367514;7320.853582928418;7392.334689877936;7416.369608583331;7429.182789893;6856.588604683735;6997.477711460099;7076.1508618964;7153.070100886852;7206.7117315306805;6754.292245384632;6757.391834734897;6791.252962174256;6854.0404343390965;6881.628216570339;7142.9285707144345;7154.749583764543;7184.9640751795905;7190.496665233383;7192.8921066183;6564.343565643589;6602.339766023551;6620.238672552526;6629.5359324846795;6645.036469711768;6516.185476815398;6579.671016449062;6621.801345959629;6625.304343043911;6653.434458071119 05:23:42 INFO - PROCESS | 22279 | |4;prototype.html;336.0824947892254;336.87030493260096;342.2641321159508;346.4647120199293;349.26305495404694;6262.499000079994;6264.373562643734;6305.274893387262;6329;6419.422251997331;6184.690765461732;6301.621902685842;6313.873722525546;6332.3351048139975;6336.619802811834;4819.7590120494015;4847.927281090787;4859.635527335447;4863.31913532104;4869.5130486951375;4865.221564549673;4867.561919427251;4876.780544875472;4877.317175595419;4881.438634557018;4741.834035808747;4839.080574690815;4846.151923413407;4847.806087756486;4849.442314133885;4782.115308667908;4809.422869255694;4822.373091498101;4824.035192961422;4835.709857408567;4202.810873510669;4204.222218889515;4212.073343864345;4224.640905523034;4229.72506787061;5888.5289176865745;5976.61152025117;6001.159837622693;6015.0375939849855;6015.939840601582;5634.183043458716;5661.122526008476;5672.9432705672825;5674.432556744334;5678.063119585264;6652.068710380502;6711.295313992009;6715.2613212546585;6726.024726414691;6733.259341472434;4654.697444666086;4672.299155126724;4676.462206846189;4686.835960741392;4686.976565117153;6879.690413931385;6992.335728105771;7000.439964802804;7007.474439417064;7024.297570242935;4816.8073277069225;4819.734914579732;4821.710697358099;4828.348172996671;4828.686135401258;4845.878853028632;4850.514948505192;4859.34398856157;4866.659333846596;4893.241547560134;5504.697241651667;5599.272094627672;5606.299212598426;5612.663240205601;5614.747336369873;6744.5616034957575;6744.763933262312;6753.1220941277315;6767.695453704595;6798.150231221098;1636.8772342074392;1679.529731675133;1680.6218600814718;1686.3591835102582;1703.1654489300154;1092.3937214845837;1109.6560066379448;1124.0951034417374;1126.099120703434;1133.7449073958294;6086.6348019119;6168.568200226031;6197.4732147767045;6257.186565746424;6341.873162536724;6820;6825.112735344473;6829.180498340231;6830.282820303896;6873.381395674413;6095.1771510845465;6252.093446450239;6254.8123556293385;6256.374362563707;6277.843053923689;3700.648438398348;3718.6095459976314;3739.3082279778328;3739.9065023374087;3742.214135031619;7124.715011399486;7148.606826624586;7150.7497237596435;7171.390431813355;7172.677229524684;6963.1296087989;6965.930340696629;6982.860342793218;7000.264972177848;7007.124109486314;7222.205557388683;7244.166920804069;7270.382017528569;7367.336939675455;7389.889151662729;7001.264867188872;7001.404880585207;7018.403435708022;7036.8592628146125;7050.717971281091;6817.89773153413;6897.172339319314;6910.343517366044;6915.481338899502;6969.6515174242095;7313.232110628307;7323.560586364835;7342.70629174827;7354.411647068115;7363.2268611797135;4653.092646933816;4674.742889140994;4699.53004699541;4707.317438971399;4728;6953.513254072166;7066.04608377883;7072.151341839012;7074.257202993612;7085.078939737801;6722.092517510074;6778.288279730557;6802.829929251809;6807.591544507345;6820.727170913108;6753.459723222229;6783.18601767791;6785.830354241183;6799;6812.965935170292;6509.707063182073;6655.800325990228;6678.098456708476;6679.23188833271;6683.365080317362;6838.452923765987;6860.142482189726;6864.553804002724;6865.862682746218;6881.759138430131;6551;6659.467242620675;6686;6698.162729658793;6713.597184168965 05:23:42 INFO - PROCESS | 22279 | |5;yui.html;745.5414919824308;820.8932838730964;840.4285086141422;851.808343122797;878.1131057631792;12047.518099276029;12072.275663460177;12148.27110373376;12154.270743755369;12240.81638775418;12228.144029917887;12323.445444954976;12389.070819688537;12463.626091217255;12734;803.0884945586772;816.94281400302;818.5007145641155;819.4714409206058;820.0405525535139;791.0428381658201;798.1858504325585;798.6805277888833;798.7723498802842;801.8115742800437;849.3502470609989;849.5072857742495;853.3727710133047;853.8420392227458;854.0221446443818;847.7838151271447;853.5561508015859;856.0326830681353;857.0358346859783;857.8841856349406;627.4509803921569;627.7175271127965;627.9560430769848;628.4030171337203;629.9338569450233;12666.620001399973;12681.175723577939;12711.173773704772;12716.300603466805;12731.427085781163;10619.20355973305;10785.5685772569;10965.067969222626;10989.945050274777;11394.088472922147;9673.419594824263;9775.951120244425;9802.754931126708;9814.46020468874;9831.754206144831;3400.9659903401143;3509.6841284284283;3522.982385088084;3540.8760693375607;3543.3976224041976;41507.377389339184;41578.79210603958;43685;45277.32084018776;45486.31770523445;9837.704868853803;9842.114209721016;9878.901210987799;9983.450910199863;10043.347182433265;14751.336189871266;14841.183734894468;14872.479463218951;14951.626209344637;14969.775453368207;7177.389921856597;7210.67551960163;7405.407567394595;7434.145073316529;7526.134494533198;4089.7750623715983;4108.609682080198;4233.957660423418;4307.935380969288;4311.741295522279;3162.98418507906;3176.7140957313954;3183.8567264473154;3200.2639392939755;3211.3737821124655;559.4098226371217;569.6582050769588;580.2138102870634;580.3847921203537;580.7096451774113;558.7178474870165;583.8751496798552;605.5821483176594;636.4233010481125;672.3881268046055;8471.195236452528;8901.599428025755;8955.552222388986;8956.841686555239;8979.775505612412;536.841631718644;569.46754784276;629.9527535434861;632.4213344789466;672.7779832655212;3950.2889479893897;3959.3862951242027;4007.238624661305;4018.9901764653355;4106.938395924063;54371.184432233546;58122.7093864528;58167.70916145477;58232.41767582355;58372;46522.76738616353;48530.5146948526;50324.245136322985;50900.490995089574;51851;44061.33907991383;45225.09549808985;45377.31934020992;45650;46049.30926036112;8318.41771076043;8404.20160084791;8943.37396382247;8953.776155596162;8972.641094356413;33920.66079339274;34430.311393772485;34714.65285347114;35644.82177589095;35665.28669426545;40832.18335633211;41515.7924210377;41794.58205417907;45908;47045.76477117593;10397.740056498647;10461.26771126014;10467.371957682564;10585;10591.20565957541;10675.457320114241;10744.844720496894;10946.288491248044;11060.612878549213;11312.717182070513;10604.469776510989;10783.352998820095;10813.729656758644;10981.890181098086;11006.339619622848;10753.085987691135;10818.849149911746;11041.503132358903;11061.336319820837;11697.06423486136;10802.567897284021;10871.29336593119;10998.175136864927;11017.669469915916;11548.191626586058;8596.968363796384;8633.30933525329;8860.601272942604;8965.955170224108;9189.402688825205;8293.917060829315;8850.114988501098;9069.319801014819;9157.650695517976;9178.449293042439 05:23:42 INFO - PROCESS | 22279 | __end_tp_report 05:23:42 INFO - PROCESS | 22279 | __start_cc_report 05:23:42 INFO - PROCESS | 22279 | _x_x_mozilla_cycle_collect,316 05:23:42 INFO - PROCESS | 22279 | __end_cc_report 05:23:42 INFO - PROCESS | 22279 | __startTimestamp1452605022624__endTimestamp 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | ------- Summary: start ------- 05:23:42 INFO - PROCESS | 22279 | Number of tests: 6 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | [#0] dojo.html Cycles:165 Average:5402.75 Median:5608.05 stddev:598.68 (10.7%) stddev-sans-first:575.93 05:23:42 INFO - PROCESS | 22279 | Values: 3238.2 3261.6 3296.9 3310.4 3316.9 5306.3 5380.1 5383.1 5389.8 5389.9 5319.1 5416.1 5450.3 5509.3 5522.5 4552.6 4896.7 4993.4 4995.0 5020.1 4835.4 4970.8 5049.5 5067.9 5080.8 4793.5 4871.0 4876.8 4878.9 4890.9 4913.0 4917.6 4924.4 4947.2 4956.7 4817.1 4897.3 4897.6 4945.2 4953.9 5113.5 5141.3 5193.7 5300.3 5361.0 5737.7 5764.7 5784.4 5789.0 5798.6 5729.6 5848.8 5858.0 5862.1 5876.6 5429.4 5433.8 5467.2 5488.1 5555.3 5950.7 5956.3 5971.5 5998.6 6010.5 5469.3 5523.1 5723.0 5749.3 5756.9 5838.7 5888.1 5906.9 5918.6 5966.9 5791.6 5835.5 5854.3 5854.9 5858.5 5608.0 5709.0 5856.5 5883.6 5887.2 4474.8 4540.9 4544.8 4579.0 4587.2 4016.8 4045.9 4055.6 4061.3 4098.3 5405.1 5423.9 5481.5 5485.3 5521.6 5811.7 5847.2 5864.2 5880.1 5889.3 5467.4 5467.6 5482.5 5485.5 5493.6 4858.1 4926.7 4933.8 4937.5 5024.5 6019.1 6022.3 6031.8 6035.3 6047.5 5769.5 5797.7 5800.4 5815.1 5816.1 5963.7 6020.9 6071.5 6095.9 6127.7 5697.4 5699.1 5699.3 5700.2 5702.2 5750.1 5764.6 5813.7 5814.4 5822.5 5643.6 5658.8 5707.9 5709.0 5751.7 5690.6 5693.6 5714.0 5715.7 5736.6 5563.5 5603.6 5633.4 5639.4 5663.1 5721.3 5803.5 5806.4 5810.9 5816.5 5573.6 5590.7 5596.2 5639.7 5646.7 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | [#1] ext.html Cycles:180 Average:49162.56 Median:21430.59 stddev:89436.83 (417.3%) stddev-sans-first:89613.13 05:23:42 INFO - PROCESS | 22279 | Values: 512.0 513.3 548.2 567.8 575.7 28127.7 36679.4 37196.3 37417.4 37534.6 40398.0 40648.6 40915.0 41075.8 41153.8 8463.4 8566.3 8684.7 8685.0 8697.7 8407.6 8440.6 8448.1 8479.2 8528.2 8472.8 8538.4 8543.1 8546.4 8566.3 8446.1 8518.8 8559.0 8758.7 8776.0 8457.3 8559.3 8573.0 8574.5 8713.3 39697.8 40354.8 40420.6 40531.8 40595.4 3329.3 3480.5 3487.7 3769.4 3836.6 29676.4 29794.7 29849.3 29998.4 30909.1 3887.8 3944.0 3956.9 4021.4 4073.1 260344.0 260496.0 260919.0 261508.0 261896.0 42824.6 43191.6 43216.6 58027.0 58798.4 43502.8 43751.9 43758.0 43784.6 43878.8 13856.9 14067.1 14206.8 14227.4 14239.4 11890.3 12136.6 12235.8 12243.6 12247.6 14409.4 14582.2 14590.5 14659.8 14682.9 5716.6 5723.7 5752.5 5771.0 5813.2 876.0 943.4 945.2 954.4 1013.3 26571.7 27833.0 28298.3 28311.0 28359.3 1038.1 1040.6 1047.3 1051.8 1106.2 14429.8 14790.6 14856.4 14871.3 16387.8 415483.0 417483.0 423885.0 423991.0 424167.0 55299.0 55414.4 55788.4 55825.4 56078.2 1333.6 1351.8 1356.3 1361.6 1366.7 29611.4 30393.7 30869.8 30965.7 31106.0 47171.8 47408.5 47517.3 47703.3 47770.3 315043.4 316519.0 317085.0 317389.0 318454.0 32168.2 42348.2 43025.8 43808.6 43824.6 41196.2 41874.8 42107.8 42656.6 43244.0 36426.6 36726.0 37235.1 38568.3 40142.0 35558.3 36986.3 37025.6 37212.2 37551.4 36240.8 36598.1 36601.6 38389.2 38973.4 29767.7 31370.5 33186.2 33460.8 33804.3 25195.4 25499.6 25814.7 26982.6 27338.7 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | [#2] jquery.html Cycles:180 Average:24263.65 Median:46502.92 stddev:75687.93 (162.8%) stddev-sans-first:75878.96 05:23:42 INFO - PROCESS | 22279 | Values: 353.9 357.8 357.9 359.3 361.0 15952.8 16040.4 16685.6 16962.6 17740.8 15008.4 15106.5 15489.3 15494.4 15516.6 4705.1 4885.5 4889.7 4891.0 4893.8 4372.8 4743.5 4766.7 4884.0 4890.0 5020.0 5054.8 5055.4 5256.7 5273.8 5188.4 5210.3 5230.0 5499.2 6002.3 5261.6 5272.4 5279.4 5281.7 5305.9 12090.8 12903.7 12935.9 12954.4 12976.4 2002.9 2050.5 2089.4 2108.2 2169.2 9210.4 9277.8 9490.2 9725.1 9752.3 1759.9 1838.7 1841.6 1865.4 1870.1 54481.2 55042.2 55819.0 56607.7 56897.4 9497.0 9559.4 9579.1 9654.8 9706.8 12230.8 12322.9 12336.3 12422.7 12430.9 7428.7 7429.2 7440.2 7469.9 7491.8 7346.2 7396.9 7398.7 7437.4 7443.4 4043.8 4121.7 4122.2 4155.7 4260.1 1669.3 1671.1 1707.9 1723.6 1726.7 452.9 456.6 468.5 967.7 1026.7 15515.8 15515.8 15860.0 16432.9 16495.5 918.3 931.7 938.9 946.9 957.6 9022.0 9058.2 9191.1 9225.5 9475.5 419422.0 424925.0 426785.0 428111.0 595682.0 38380.6 38651.2 42800.8 47529.0 62956.4 1093.9 1135.7 1148.6 1148.6 1149.2 14324.4 14353.6 14400.9 14635.9 14654.6 32211.7 32755.7 32907.5 33013.5 33356.8 41349.8 46440.8 46565.1 46711.8 46940.5 6887.7 7093.9 7106.0 7230.2 7577.0 10314.0 11508.6 11522.6 11594.7 11821.8 9020.8 9406.9 9893.0 9959.2 10121.2 9578.7 9864.8 10133.1 10273.9 10428.3 9641.0 9982.5 10023.3 10293.3 10308.2 7143.6 7260.7 7344.7 7462.2 7538.7 8247.0 9729.3 9901.9 9904.2 10052.9 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | [#3] mootools.html Cycles:180 Average:5519.13 Median:6583.96 stddev:2816.65 (42.8%) stddev-sans-first:2807.96 05:23:42 INFO - PROCESS | 22279 | Values: 1451.3 1460.8 1604.6 1744.2 1763.5 7498.7 7657.5 7770.0 7814.2 7864.9 7839.3 7877.3 7955.8 7975.4 7981.4 2404.8 2442.5 2444.8 2446.1 2449.9 2365.1 2418.4 2418.6 2420.5 2443.5 2333.8 2393.9 2408.1 2413.9 2428.3 2337.0 2355.8 2398.9 2401.5 2405.2 2360.9 2369.3 2370.3 2373.8 2386.1 7472.4 7514.0 7518.5 7542.3 7560.1 4695.1 4755.8 4766.2 4817.9 4845.8 3036.3 3109.3 3122.9 3135.7 3142.5 981.8 986.6 1007.4 1007.5 1010.9 10778.4 10818.1 10865.8 10871.7 10897.3 4334.8 4461.6 4512.7 4550.1 4591.9 9464.0 9477.0 9479.2 9482.8 9486.2 4914.2 4945.2 4952.5 4957.0 4974.1 4378.6 4401.9 4417.7 4432.7 4439.3 3737.7 3766.3 3768.5 3792.5 3816.6 1139.5 1227.2 1263.2 1269.7 1274.8 1015.3 1043.5 1045.8 1219.5 1357.7 7327.9 7387.0 7399.4 7412.4 7427.6 1029.7 1042.6 1046.5 1061.3 1148.2 5487.3 5533.6 5595.3 5631.2 5663.2 9270.9 9465.3 9480.6 9578.7 9630.6 8831.2 9330.7 9433.3 9440.3 9472.5 7254.9 7324.7 7373.2 7406.4 7412.0 7242.3 7321.9 7367.0 7372.0 7402.1 8124.5 8296.6 8353.1 8433.0 8446.5 8359.5 8572.1 8589.4 8627.5 8707.1 6588.2 6676.5 6710.9 6718.9 6745.6 7176.5 7320.9 7392.3 7416.4 7429.2 6856.6 6997.5 7076.2 7153.1 7206.7 6754.3 6757.4 6791.3 6854.0 6881.6 7142.9 7154.7 7185.0 7190.5 7192.9 6564.3 6602.3 6620.2 6629.5 6645.0 6516.2 6579.7 6621.8 6625.3 6653.4 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | [#4] prototype.html Cycles:180 Average:5626.43 Median:6271.11 stddev:1706.91 (27.2%) stddev-sans-first:1664.87 05:23:42 INFO - PROCESS | 22279 | Values: 336.1 336.9 342.3 346.5 349.3 6262.5 6264.4 6305.3 6329.0 6419.4 6184.7 6301.6 6313.9 6332.3 6336.6 4819.8 4847.9 4859.6 4863.3 4869.5 4865.2 4867.6 4876.8 4877.3 4881.4 4741.8 4839.1 4846.2 4847.8 4849.4 4782.1 4809.4 4822.4 4824.0 4835.7 4202.8 4204.2 4212.1 4224.6 4229.7 5888.5 5976.6 6001.2 6015.0 6015.9 5634.2 5661.1 5672.9 5674.4 5678.1 6652.1 6711.3 6715.3 6726.0 6733.3 4654.7 4672.3 4676.5 4686.8 4687.0 6879.7 6992.3 7000.4 7007.5 7024.3 4816.8 4819.7 4821.7 4828.3 4828.7 4845.9 4850.5 4859.3 4866.7 4893.2 5504.7 5599.3 5606.3 5612.7 5614.7 6744.6 6744.8 6753.1 6767.7 6798.2 1636.9 1679.5 1680.6 1686.4 1703.2 1092.4 1109.7 1124.1 1126.1 1133.7 6086.6 6168.6 6197.5 6257.2 6341.9 6820.0 6825.1 6829.2 6830.3 6873.4 6095.2 6252.1 6254.8 6256.4 6277.8 3700.6 3718.6 3739.3 3739.9 3742.2 7124.7 7148.6 7150.7 7171.4 7172.7 6963.1 6965.9 6982.9 7000.3 7007.1 7222.2 7244.2 7270.4 7367.3 7389.9 7001.3 7001.4 7018.4 7036.9 7050.7 6817.9 6897.2 6910.3 6915.5 6969.7 7313.2 7323.6 7342.7 7354.4 7363.2 4653.1 4674.7 4699.5 4707.3 4728.0 6953.5 7066.0 7072.2 7074.3 7085.1 6722.1 6778.3 6802.8 6807.6 6820.7 6753.5 6783.2 6785.8 6799.0 6813.0 6509.7 6655.8 6678.1 6679.2 6683.4 6838.5 6860.1 6864.6 6865.9 6881.8 6551.0 6659.5 6686.0 6698.2 6713.6 05:23:42 INFO - PROCESS | 22279 | 05:23:42 INFO - PROCESS | 22279 | [#5] yui.html Cycles:180 Average:13208.56 Median:46784.27 stddev:15464.43 (33.1%) stddev-sans-first:15479.49 05:23:42 INFO - PROCESS | 22279 | Values: 745.5 820.9 840.4 851.8 878.1 12047.5 12072.3 12148.3 12154.3 12240.8 12228.1 12323.4 12389.1 12463.6 12734.0 803.1 816.9 818.5 819.5 820.0 791.0 798.2 798.7 798.8 801.8 849.4 849.5 853.4 853.8 854.0 847.8 853.6 856.0 857.0 857.9 627.5 627.7 628.0 628.4 629.9 12666.6 12681.2 12711.2 12716.3 12731.4 10619.2 10785.6 10965.1 10989.9 11394.1 9673.4 9776.0 9802.8 9814.5 9831.8 3401.0 3509.7 3523.0 3540.9 3543.4 41507.4 41578.8 43685.0 45277.3 45486.3 9837.7 9842.1 9878.9 9983.5 10043.3 14751.3 14841.2 14872.5 14951.6 14969.8 7177.4 7210.7 7405.4 7434.1 7526.1 4089.8 4108.6 4234.0 4307.9 4311.7 3163.0 3176.7 3183.9 3200.3 3211.4 559.4 569.7 580.2 580.4 580.7 558.7 583.9 605.6 636.4 672.4 8471.2 8901.6 8955.6 8956.8 8979.8 536.8 569.5 630.0 632.4 672.8 3950.3 3959.4 4007.2 4019.0 4106.9 54371.2 58122.7 58167.7 58232.4 58372.0 46522.8 48530.5 50324.2 50900.5 51851.0 44061.3 45225.1 45377.3 45650.0 46049.3 8318.4 8404.2 8943.4 8953.8 8972.6 33920.7 34430.3 34714.7 35644.8 35665.3 40832.2 41515.8 41794.6 45908.0 47045.8 10397.7 10461.3 10467.4 10585.0 10591.2 10675.5 10744.8 10946.3 11060.6 11312.7 10604.5 10783.4 10813.7 10981.9 11006.3 10753.1 10818.8 11041.5 11061.3 11697.1 10802.6 10871.3 10998.2 11017.7 11548.2 8597.0 8633.3 8860.6 8966.0 9189.4 8293.9 8850.1 9069.3 9157.7 9178.4 05:23:42 INFO - PROCESS | 22279 | -------- Summary: end -------- 05:23:42 INFO - PROCESS | 22279 | 05:23:43 INFO - TEST-INFO | 22279: exit 0 05:23:43 INFO - TEST-OK | dromaeo_css | took 1109896ms 05:23:43 INFO - TEST-START | kraken 05:23:43 INFO - operating with platform_type : linux_ 05:23:43 INFO - Initialising browser for kraken test... 05:23:43 INFO - TEST-INFO | started process 22521 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUiwZPm/profile http://localhost:44652/getInfo.html) 05:23:46 INFO - PROCESS | 22521 | 05:23:46 INFO - PROCESS | 22521 | (process:22592): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:23:47 INFO - PROCESS | 22521 | __metrics Screen width/height:1600/1200 05:23:47 INFO - PROCESS | 22521 | colorDepth:24 05:23:47 INFO - PROCESS | 22521 | Browser inner width/height: 1024/697 05:23:47 INFO - PROCESS | 22521 | __metrics 05:23:47 INFO - PROCESS | 22521 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:23:48 INFO - TEST-INFO | 22521: exit 0 05:23:48 INFO - Browser initialized. 05:23:48 INFO - Running cycle 1/1 for kraken test... 05:23:48 INFO - TEST-INFO | started process 22641 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUiwZPm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:49 INFO - PROCESS | 22641 | 05:23:49 INFO - PROCESS | 22641 | (process:22699): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:23:59 INFO - PROCESS | 22641 | RSS: Main: 150921216 05:23:59 INFO - PROCESS | 22641 | 05:24:02 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44652/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:02 INFO - PROCESS | 22641 | RSS: Main: 152358912 05:24:02 INFO - PROCESS | 22641 | 05:24:05 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44652/tests/kraken/driver.html?testName=audio-dft) 05:24:06 INFO - PROCESS | 22641 | RSS: Main: 151883776 05:24:06 INFO - PROCESS | 22641 | 05:24:09 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44652/tests/kraken/driver.html?testName=audio-fft) 05:24:09 INFO - PROCESS | 22641 | RSS: Main: 147083264 05:24:09 INFO - PROCESS | 22641 | 05:24:11 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44652/tests/kraken/driver.html?testName=audio-oscillator) 05:24:12 INFO - PROCESS | 22641 | RSS: Main: 147087360 05:24:12 INFO - PROCESS | 22641 | 05:24:14 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:15 INFO - PROCESS | 22641 | RSS: Main: 146739200 05:24:15 INFO - PROCESS | 22641 | 05:24:18 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44652/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:18 INFO - PROCESS | 22641 | RSS: Main: 146944000 05:24:18 INFO - PROCESS | 22641 | 05:24:22 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44652/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:22 INFO - PROCESS | 22641 | RSS: Main: 148262912 05:24:22 INFO - PROCESS | 22641 | 05:24:25 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44652/tests/kraken/driver.html?testName=json-parse-financial) 05:24:26 INFO - PROCESS | 22641 | RSS: Main: 148520960 05:24:26 INFO - PROCESS | 22641 | 05:24:27 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:28 INFO - PROCESS | 22641 | RSS: Main: 149356544 05:24:28 INFO - PROCESS | 22641 | 05:24:30 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:30 INFO - PROCESS | 22641 | RSS: Main: 148930560 05:24:30 INFO - PROCESS | 22641 | 05:24:32 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:33 INFO - PROCESS | 22641 | RSS: Main: 148586496 05:24:33 INFO - PROCESS | 22641 | 05:24:35 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:36 INFO - PROCESS | 22641 | RSS: Main: 148828160 05:24:36 INFO - PROCESS | 22641 | 05:24:39 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:39 INFO - PROCESS | 22641 | RSS: Main: 148643840 05:24:39 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | Cycle 1(1): loaded http://localhost:44652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44652/tests/kraken/driver.html?testName=ai-astar) 05:24:41 INFO - PROCESS | 22641 | RSS: Main: 148946944 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | __start_tp_report 05:24:41 INFO - PROCESS | 22641 | _x_x_mozilla_page_load 05:24:41 INFO - PROCESS | 22641 | _x_x_mozilla_page_load_details 05:24:41 INFO - PROCESS | 22641 | |i|pagename|runs| 05:24:41 INFO - PROCESS | 22641 | |0;ai-astar;113;106;113;113;112;121;114;113;112;113 05:24:41 INFO - PROCESS | 22641 | |1;audio-beat-detection;156;123;150;168;124;149;163;128;164;134 05:24:41 INFO - PROCESS | 22641 | |2;audio-dft;162;165;163;163;164;162;160;163;169;162 05:24:41 INFO - PROCESS | 22641 | |3;audio-fft;74;75;73;71;75;71;144;72;71;74 05:24:41 INFO - PROCESS | 22641 | |4;audio-oscillator;94;100;140;96;97;96;139;94;96;146 05:24:41 INFO - PROCESS | 22641 | |5;imaging-gaussian-blur;111;109;109;110;109;109;109;110;110;110 05:24:41 INFO - PROCESS | 22641 | |6;imaging-darkroom;146;146;146;147;148;146;147;146;146;146 05:24:41 INFO - PROCESS | 22641 | |7;imaging-desaturate;97;97;96;97;97;97;97;96;97;96 05:24:41 INFO - PROCESS | 22641 | |8;json-parse-financial;58;57;56;56;56;57;56;64;55;55 05:24:41 INFO - PROCESS | 22641 | |9;json-stringify-tinderbox;67;68;68;69;68;69;68;68;70;69 05:24:41 INFO - PROCESS | 22641 | |10;stanford-crypto-aes;84;88;87;87;86;88;88;87;90;88 05:24:41 INFO - PROCESS | 22641 | |11;stanford-crypto-ccm;128;134;116;124;121;134;118;130;123;119 05:24:41 INFO - PROCESS | 22641 | |12;stanford-crypto-pbkdf2;146;158;158;158;166;143;145;145;155;141 05:24:41 INFO - PROCESS | 22641 | |13;stanford-crypto-sha256-iterative;67;69;68;68;69;69;68;67;67;72 05:24:41 INFO - PROCESS | 22641 | __end_tp_report 05:24:41 INFO - PROCESS | 22641 | __start_cc_report 05:24:41 INFO - PROCESS | 22641 | _x_x_mozilla_cycle_collect,732 05:24:41 INFO - PROCESS | 22641 | __end_cc_report 05:24:41 INFO - PROCESS | 22641 | __startTimestamp1452605081698__endTimestamp 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | ------- Summary: start ------- 05:24:41 INFO - PROCESS | 22641 | Number of tests: 14 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:3.59 (3.2%) stddev-sans-first:3.81 05:24:41 INFO - PROCESS | 22641 | Values: 113.0 106.0 113.0 113.0 112.0 121.0 114.0 113.0 112.0 113.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:153.00 stddev:17.33 (11.3%) stddev-sans-first:17.99 05:24:41 INFO - PROCESS | 22641 | Values: 156.0 123.0 150.0 168.0 124.0 149.0 163.0 128.0 164.0 134.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.41 (1.5%) stddev-sans-first:2.51 05:24:41 INFO - PROCESS | 22641 | Values: 162.0 165.0 163.0 163.0 164.0 162.0 160.0 163.0 169.0 162.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#3] audio-fft Cycles:10 Average:80.00 Median:73.50 stddev:22.54 (30.7%) stddev-sans-first:23.81 05:24:41 INFO - PROCESS | 22641 | Values: 74.0 75.0 73.0 71.0 75.0 71.0 144.0 72.0 71.0 74.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.00 stddev:22.12 (23.3%) stddev-sans-first:22.72 05:24:41 INFO - PROCESS | 22641 | Values: 94.0 100.0 140.0 96.0 97.0 96.0 139.0 94.0 96.0 146.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 05:24:41 INFO - PROCESS | 22641 | Values: 111.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 05:24:41 INFO - PROCESS | 22641 | Values: 146.0 146.0 146.0 147.0 148.0 146.0 147.0 146.0 146.0 146.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:24:41 INFO - PROCESS | 22641 | Values: 97.0 97.0 96.0 97.0 97.0 97.0 97.0 96.0 97.0 96.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:2.62 (4.6%) stddev-sans-first:2.76 05:24:41 INFO - PROCESS | 22641 | Values: 58.0 57.0 56.0 56.0 56.0 57.0 56.0 64.0 55.0 55.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.73 05:24:41 INFO - PROCESS | 22641 | Values: 67.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 70.0 69.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:88.00 stddev:1.57 (1.8%) stddev-sans-first:1.12 05:24:41 INFO - PROCESS | 22641 | Values: 84.0 88.0 87.0 87.0 86.0 88.0 88.0 87.0 90.0 88.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.00 stddev:6.52 (5.2%) stddev-sans-first:6.80 05:24:41 INFO - PROCESS | 22641 | Values: 128.0 134.0 116.0 124.0 121.0 134.0 118.0 130.0 123.0 119.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:156.50 stddev:8.48 (5.4%) stddev-sans-first:8.75 05:24:41 INFO - PROCESS | 22641 | Values: 146.0 158.0 158.0 158.0 166.0 143.0 145.0 145.0 155.0 141.0 05:24:41 INFO - PROCESS | 22641 | 05:24:41 INFO - PROCESS | 22641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.51 (2.2%) stddev-sans-first:1.51 05:24:41 INFO - PROCESS | 22641 | Values: 67.0 69.0 68.0 68.0 69.0 69.0 68.0 67.0 67.0 72.0 05:24:41 INFO - PROCESS | 22641 | -------- Summary: end -------- 05:24:41 INFO - PROCESS | 22641 | 05:24:42 INFO - TEST-INFO | 22641: exit 0 05:24:42 INFO - TEST-OK | kraken | took 59277ms 05:24:42 INFO - TEST-START | v8_7 05:24:42 INFO - operating with platform_type : linux_ 05:24:42 INFO - Initialising browser for v8_7 test... 05:24:42 INFO - TEST-INFO | started process 22927 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9hNfKv/profile http://localhost:44652/getInfo.html) 05:24:45 INFO - PROCESS | 22927 | 05:24:45 INFO - PROCESS | 22927 | (process:22999): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:24:46 INFO - PROCESS | 22927 | __metrics Screen width/height:1600/1200 05:24:46 INFO - PROCESS | 22927 | colorDepth:24 05:24:46 INFO - PROCESS | 22927 | Browser inner width/height: 1024/697 05:24:46 INFO - PROCESS | 22927 | __metrics 05:24:46 INFO - PROCESS | 22927 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:24:47 INFO - TEST-INFO | 22927: exit 0 05:24:47 INFO - Browser initialized. 05:24:47 INFO - Running cycle 1/1 for v8_7 test... 05:24:47 INFO - TEST-INFO | started process 23048 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9hNfKv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:48 INFO - PROCESS | 23048 | 05:24:48 INFO - PROCESS | 23048 | (process:23108): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:24:59 INFO - PROCESS | 23048 | RSS: Main: 151035904 05:24:59 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | Cycle 1(1): loaded http://localhost:44652/tests/v8_7/run.html (next: http://localhost:44652/tests/v8_7/run.html) 05:25:21 INFO - PROCESS | 23048 | RSS: Main: 146829312 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | __start_tp_report 05:25:21 INFO - PROCESS | 23048 | _x_x_mozilla_page_load 05:25:21 INFO - PROCESS | 23048 | _x_x_mozilla_page_load_details 05:25:21 INFO - PROCESS | 23048 | |i|pagename|runs| 05:25:21 INFO - PROCESS | 23048 | |0;Richards;170.47391749062393 05:25:21 INFO - PROCESS | 23048 | |1;DeltaBlue;188.96447467876038 05:25:21 INFO - PROCESS | 23048 | |2;Encrypt;279.3296089385475 05:25:21 INFO - PROCESS | 23048 | |3;Decrypt;5240.837696335078 05:25:21 INFO - PROCESS | 23048 | |4;RayTrace;1061.5711252653928 05:25:21 INFO - PROCESS | 23048 | |5;Earley;753.5795026375282 05:25:21 INFO - PROCESS | 23048 | |6;Boyer;12071.42857142857 05:25:21 INFO - PROCESS | 23048 | |7;RegExp;42854.166666666664 05:25:21 INFO - PROCESS | 23048 | |8;Splay;589.9705014749262 05:25:21 INFO - PROCESS | 23048 | |9;NavierStokes;4864.077669902913 05:25:21 INFO - PROCESS | 23048 | __end_tp_report 05:25:21 INFO - PROCESS | 23048 | __startTimestamp1452605121826__endTimestamp 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | ------- Summary: start ------- 05:25:21 INFO - PROCESS | 23048 | Number of tests: 10 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#0] Richards Cycles:1 Average:170.47 Median:170.47 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 170.5 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#1] DeltaBlue Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 189.0 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 279.3 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 5240.8 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 1061.6 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#5] Earley Cycles:1 Average:753.58 Median:753.58 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 753.6 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#6] Boyer Cycles:1 Average:12071.43 Median:12071.43 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 12071.4 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#7] RegExp Cycles:1 Average:42854.17 Median:42854.17 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 42854.2 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#8] Splay Cycles:1 Average:589.97 Median:589.97 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 590.0 05:25:21 INFO - PROCESS | 23048 | 05:25:21 INFO - PROCESS | 23048 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 05:25:21 INFO - PROCESS | 23048 | Values: 4864.1 05:25:21 INFO - PROCESS | 23048 | -------- Summary: end -------- 05:25:21 INFO - PROCESS | 23048 | 05:25:22 INFO - TEST-INFO | 23048: exit 0 05:25:22 INFO - TEST-OK | v8_7 | took 40080ms 05:25:22 INFO - SUITE-END | took 1209s 05:25:22 INFO - Completed test suite (00:20:09) 05:25:22 INFO - Working with test: dromaeo_css 05:25:22 INFO - Generating results file: dromaeo_css 05:25:22 INFO - Working with test: kraken 05:25:22 INFO - Generating results file: kraken 05:25:22 INFO - javascript benchmark 05:25:22 INFO - Working with test: v8_7 05:25:22 INFO - Generating results file: v8_7 05:25:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:25:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:25:22 INFO - process_Request line: dromaeo_css 6882.94 graph.html#tests=[[72,64,43]] 05:25:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:25:22 INFO - process_Request line: kraken 1522.00 graph.html#tests=[[232,64,43]] 05:25:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:25:22 INFO - process_Request line: v8_7 20199.11 graph.html#tests=[[230,64,43]] 05:25:22 INFO - RETURN: dromaeo_css: 6882.94 05:25:22 INFO - RETURN: kraken: 1522.00 05:25:22 INFO - RETURN: v8_7: 20199.11 05:25:22 INFO - javascript benchmark 05:25:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3238.206639373353, 3261.59230096238, 3296.8681252749893, 3310.387578298016, 3316.9004929852113, 5306.257124002633, 5380.058489764295, 5383.057964856154, 5389.811356602515, 5389.868127693184, 5319.069162896497, 5416.052190866602, 5450.264214331064, 5509.311336082989, 5522.502974732273, 4552.567506086916, 4896.706197628145, 4993.400791904976, 4995.025969935864, 5020.121478741224, 4835.371401717772, 4970.801167953277, 5049.4698056704065, 5067.923981140286, 5080.822171224008, 4793.520647935214, 4871.0, 4876.756162191911, 4878.878028049292, 4890.902181956377, 4913.041956818422, 4917.582005529534, 4924.433690125646, 4947.158982972904, 4956.677815941952, 4817.084753896748, 4897.33885925399, 4897.6326775491625, 4945.159322915113, 4953.900921981576, 5113.53978141969, 5141.2545180948555, 5193.740312984373, 5300.257963885059, 5361.0, 5737.713114344266, 5764.711764411804, 5784.421557844224, 5788.97105514474, 5798.565107616945, 5729.570282228808, 5848.766049358021, 5857.970710146465, 5862.091375836752, 5876.559258055663, 5429.429909859447, 5433.809816656398, 5467.234587157801, 5488.094464413367, 5555.30558680165, 5950.702464876739, 5956.2852457704485, 5971.5222782177325, 5998.580099393001, 6010.519158467312, 5469.343678758495, 5523.061079616395, 5723.0, 5749.338826035059, 5756.942430575725, 5838.737256823369, 5888.057910734262, 5906.911396329058, 5918.615290006136, 5966.880662386728, 5791.5656325775735, 5835.503982161479, 5854.326752423526, 5854.912176317359, 5858.502027327725, 5608.046632072476, 5708.9714551427805, 5856.502197313276, 5883.617564858356, 5887.234659494324, 4474.821007159742, 4540.88647783808, 4544.772761361919, 4578.9771051144535, 4587.17430862448, 4016.758994460342, 4045.8786236412957, 4055.59444055598, 4061.289274376972, 4098.282800509899, 5405.081136206775, 5423.864403389947, 5481.479259470424, 5485.286912701403, 5521.585881058937, 5811.680357580289, 5847.152162936351, 5864.237649105674, 5880.088586269135, 5889.293284805851, 5467.425920278393, 5467.5625949923915, 5482.506574408322, 5485.533729632946, 5493.642913210629, 4858.05267972742, 4926.729029903389, 4933.777979990909, 4937.481564435754, 5024.497550244946, 6019.097135429721, 6022.337542870281, 6031.758729650853, 6035.30593981689, 6047.485963693048, 5769.509591684754, 5797.681127538026, 5800.4489573490455, 5815.127730840408, 5816.127580862904, 5963.671998040149, 6020.909686354796, 6071.51427885777, 6095.922000763747, 6127.662978536045, 5697.401772813795, 5699.088145896637, 5699.287589051369, 5700.2304688868135, 5702.201691763239, 5750.108733146369, 5764.625299355528, 5813.680247586423, 5814.360420353673, 5822.534197264124, 5643.604947653789, 5658.773649053992, 5707.942920570741, 5709.0, 5751.74117164737, 5690.630109042899, 5693.572982026448, 5714.028615135354, 5715.685637289823, 5736.598438109292, 5563.527100196528, 5603.5797315202335, 5633.38032816398, 5639.407862174413, 5663.093904975184, 5721.284839395075, 5803.535717142703, 5806.361300256884, 5810.854728631818, 5816.534677225896, 5573.637713548606, 5590.692511911884, 5596.216529685766, 5639.661620302795, 5646.689432081275], "unit": "score", "name": "dojo.html", "value": 5364.469819668049}, {"lowerIsBetter": false, "replicates": [511.9820806271781, 513.2890946039734, 548.2160510470028, 567.795593586309, 575.712143928036, 28127.718722812766, 36679.449808252866, 37196.25607487849, 37417.43873841895, 37534.62465375345, 40398.0, 40648.59351406485, 40915.0, 41075.79462102693, 41153.79423102888, 8463.4075614707, 8566.271866891291, 8684.739457816275, 8685.044645089036, 8697.695580654678, 8407.621657025418, 8440.57797110142, 8448.11294814045, 8479.236868681817, 8528.232459078681, 8472.83054338913, 8538.44500107494, 8543.14568543147, 8546.359023073263, 8566.271866891322, 8446.113158118402, 8518.78703032426, 8559.01571319297, 8758.693445729432, 8776.034636190014, 8457.281131103864, 8559.27246184075, 8572.957135214285, 8574.528400937947, 8713.346499012536, 39697.80151099255, 40354.79822600868, 40420.595794041976, 40531.79734101311, 40595.391069133984, 3329.267561136546, 3480.4953281774, 3487.686108250244, 3769.4345848122725, 3836.6163383661687, 29676.406471870658, 29794.702052979625, 29849.25376865574, 29998.400031999456, 30909.072727817977, 3887.766733995941, 3943.960560394417, 3956.9010774730864, 4021.416894550303, 4073.1446396256524, 260344.0, 260496.0, 260919.0, 261507.9999999981, 261896.0, 42824.57175428206, 43191.568084319384, 43216.56783432188, 58027.0, 58798.412015879294, 43502.782486087366, 43751.90620234456, 43758.0, 43784.562154378684, 43878.7806060974, 13856.93071534656, 14067.085639433404, 14206.786898196535, 14227.430902763981, 14239.430422782973, 11890.28658280506, 12136.635900922987, 12235.816462753066, 12243.632691019284, 12247.632571022705, 14409.42362305517, 14582.19797911125, 14590.489332873298, 14659.780103298459, 14682.926585367219, 5716.599838011382, 5723.713814309268, 5752.453516915886, 5770.990076736554, 5813.151555737658, 875.9693410730594, 943.3585162089845, 945.2485274207022, 954.4464210757744, 1013.2704452793977, 26571.73428265731, 27833.0, 28298.2925426866, 28311.0, 28359.29101772472, 1038.127972503101, 1040.6461802986869, 1047.2669131607904, 1051.7580956379923, 1106.231169337319, 14429.838580789374, 14790.630234244014, 14856.405743770129, 14871.33079011447, 16387.83612163887, 415483.0, 417483.0, 423885.0, 423991.0, 424167.0, 55299.0, 55414.44585554174, 55788.44211557833, 55825.44174558284, 56078.15882761762, 1333.5732565578921, 1351.7837146056584, 1356.2879488268738, 1361.5779108476404, 1366.6515038665077, 29611.407771844013, 30393.696063039086, 30869.845650771604, 30965.69034309628, 31106.0, 47171.764141179076, 47408.52591474179, 47517.287240690726, 47703.28445073257, 47770.28344574904, 315043.3982640669, 316519.0, 317085.0, 317389.0, 318454.0, 32168.195795104373, 42348.15303693971, 43025.78487107545, 43808.561914381724, 43824.56175438205, 41196.17607647771, 41874.79062604789, 42107.789461052496, 42656.57343426526, 43244.0, 36426.635733642324, 36726.0, 37235.06912327214, 38568.26442810136, 40142.0, 35558.28883422369, 36986.26027479489, 37025.629743702215, 37212.21084603448, 37551.43672844964, 36240.818795906904, 36598.08504787295, 36601.63398365982, 38389.232215354976, 38973.41539876961, 29767.70232297736, 31370.52944205793, 33186.17034574155, 33460.82504637191, 33804.32391352209, 25195.370115747253, 25499.617505737056, 25814.741852581235, 26982.595261071492, 27338.72661273362], "unit": "score", "name": "ext.html", "value": 18214.565339528635}, {"lowerIsBetter": false, "replicates": [353.9256756081223, 357.78175313059046, 357.892632210337, 359.30115924526797, 360.96751292383686, 15952.76070858938, 16040.438584649539, 16685.58286042848, 16962.575935601617, 17740.82259177408, 15008.399664013454, 15106.546803595882, 15489.302981365838, 15494.380224791023, 15516.612084697888, 4705.106029854333, 4885.462599114095, 4889.706617602955, 4891.046245982035, 4893.755312234392, 4372.841197082776, 4743.454502732178, 4766.666333356667, 4883.974365383256, 4890.046440944017, 5020.046191223656, 5054.823081192159, 5055.368078990126, 5256.710880901549, 5273.839755253857, 5188.429272779991, 5210.322658054429, 5229.973850130763, 5499.175123731432, 6002.339742628307, 5261.552768014685, 5272.367315922075, 5279.44565820591, 5281.735913204363, 5305.867353316159, 12090.758184836342, 12903.67740806478, 12935.935320323431, 12954.417051232716, 12976.416061277265, 2002.909869055896, 2050.4976280811147, 2089.373188043596, 2108.219958615307, 2169.2190811307914, 9210.401323913924, 9277.814443711088, 9490.240780737524, 9725.0761177688, 9752.317337786359, 1759.9208035638428, 1838.6966150585138, 1841.6408800283816, 1865.3564520240495, 1870.1397357215697, 54481.1827822583, 55042.17436738412, 55819.0, 56607.71696141493, 56897.43102569004, 9497.0, 9559.378640388491, 9579.089986451276, 9654.806903861883, 9706.805863882682, 12230.75538489243, 12322.876771232173, 12336.259824410565, 12422.689432764073, 12430.875691243153, 7428.665710043061, 7429.21993190718, 7440.181580026193, 7469.925300746923, 7491.775246742606, 7346.191918888918, 7396.852062958711, 7398.704051837866, 7437.442191835634, 7443.367313778282, 4043.7978101094827, 4121.670266378683, 4122.196171746481, 4155.709100362946, 4260.062786187033, 1669.3322670931725, 1671.1477146655293, 1707.8719096067844, 1723.5518765120908, 1726.7064599018197, 452.8958339581849, 456.56398139776434, 468.5478513234745, 967.7338731848798, 1026.7330494071596, 15515.767263491056, 15515.767263491056, 15860.0, 16432.917835410986, 16495.505134845975, 918.2837386838277, 931.6925414613162, 938.9248860091176, 946.9384490008127, 957.5978089202551, 9022.0, 9058.230050445654, 9191.080891910755, 9225.49259790718, 9475.478848663251, 419422.0, 424925.0, 426785.0, 428111.0, 595682.0, 38380.616193837704, 38651.22697546033, 42800.785996070445, 47529.049419011426, 62956.37043629597, 1093.9398333091756, 1135.7444574970566, 1148.5520646947698, 1148.626696323698, 1149.218531398657, 14324.427022918966, 14353.569392918229, 14400.855991439952, 14635.85364146345, 14654.56036318912, 32211.67788322087, 32755.672443275264, 32907.50638740373, 33013.50479742854, 33356.833215833765, 41349.79325103355, 46440.767796160806, 46565.068698626514, 46711.76644116893, 46940.53059469361, 6887.6556172190185, 7093.929060709327, 7105.964470177616, 7230.240824713329, 7577.014988051738, 10314.0, 11508.59719909799, 11522.596709115476, 11594.6521604352, 11821.822672659744, 9020.774480638036, 9406.905930940604, 9893.01069893005, 9959.153471954965, 10121.240906931862, 9578.664746733832, 9864.802703946025, 10133.138683211715, 10273.9486302568, 10428.322159059637, 9640.951795240979, 9982.500874956368, 10023.298369114093, 10293.330933489298, 10308.175345972455, 7143.607101609254, 7260.709571617287, 7344.70621175147, 7462.216467270859, 7538.698452061856, 8246.958765206136, 9729.318947673595, 9901.86128595192, 9904.207663387057, 10052.894181639867], "unit": "score", "name": "jquery.html", "value": 7743.25910967519}, {"lowerIsBetter": false, "replicates": [1451.2671101093947, 1460.8027916231308, 1604.5747876812648, 1744.223820399921, 1763.479773466827, 7498.737544185955, 7657.54054756715, 7770.0, 7814.179511151333, 7864.921350786491, 7839.294463498284, 7877.291043806056, 7955.840883182347, 7975.361971042317, 7981.361491080714, 2404.8076153907646, 2442.511497700458, 2444.7555244475498, 2446.0949448704005, 2449.889754961022, 2365.1485465232504, 2418.383312255381, 2418.600930846408, 2420.4674971506242, 2443.4502236996623, 2333.8132949364094, 2393.9162129325478, 2408.0728919365997, 2413.9275821725378, 2428.3079322393123, 2337.0, 2355.8233132515043, 2398.9160379386813, 2401.4836810085826, 2405.242348660184, 2360.881955902198, 2369.312899259213, 2370.3007612754277, 2373.7507561705943, 2386.1052105460453, 7472.364848987788, 7514.0, 7518.511296765692, 7542.2834830691, 7560.130584982742, 4695.060987802419, 4755.762211889391, 4766.165920963817, 4817.855464336076, 4845.806167753286, 3036.3320069584656, 3109.3159504908886, 3122.937541249185, 3135.67075457076, 3142.5443310720048, 981.8183636027358, 986.6300137448457, 1007.425767312632, 1007.5365331947313, 1010.8534262531965, 10778.353298802096, 10818.08046316064, 10865.83701244482, 10871.67384978444, 10897.291676041032, 4334.761588112621, 4461.598456138963, 4512.729236245836, 4550.135474259946, 4591.862244132682, 9463.952680236554, 9477.0, 9479.194268487256, 9482.810343793086, 9486.19367353769, 4914.164592019365, 4945.184044632667, 4952.455229924705, 4956.975215123901, 4974.104661161025, 4378.627816635558, 4401.943533551988, 4417.734935903856, 4432.734035957853, 4439.267520859022, 3737.6822970047306, 3766.3408903441787, 3768.5289338832645, 3792.544894612664, 3816.637419445148, 1139.5043156226902, 1227.2145826670937, 1263.1726219326356, 1269.7143142792982, 1274.8342715447118, 1015.279151802214, 1043.4521876015153, 1045.7594753206654, 1219.5243854896598, 1357.7216670582507, 7327.8534429312185, 7386.965824784535, 7399.4450416219, 7412.407007439392, 7427.554346739105, 1029.7425643589104, 1042.593388578455, 1046.5290619221228, 1061.310148403544, 1148.1675785055934, 5487.286652735119, 5533.557315414757, 5595.272614560081, 5631.239782629293, 5663.178839068312, 9270.90729092714, 9465.337426380225, 9480.573374198178, 9578.712638620713, 9630.614775408905, 8831.24934380572, 9330.673426430178, 9433.292503062297, 9440.339176257596, 9472.479013654178, 7254.8911766323545, 7324.707011719578, 7373.152087510005, 7406.444516661164, 7412.0, 7242.275772422716, 7321.926780732125, 7367.047732350824, 7372.041634587469, 7402.074740657418, 8124.512529248264, 8296.626651800563, 8353.122922093336, 8432.957835210786, 8446.535440550828, 8359.498430094214, 8572.142785721378, 8589.44168629037, 8627.525486098324, 8707.129287071495, 6588.242352129567, 6676.499262555425, 6710.899336509859, 6718.865622687421, 6745.5952642841585, 7176.461765367514, 7320.853582928418, 7392.334689877936, 7416.369608583331, 7429.182789893, 6856.588604683735, 6997.477711460099, 7076.1508618964, 7153.070100886852, 7206.7117315306805, 6754.292245384632, 6757.391834734897, 6791.252962174256, 6854.0404343390965, 6881.628216570339, 7142.9285707144345, 7154.749583764543, 7184.9640751795905, 7190.496665233383, 7192.8921066183, 6564.343565643589, 6602.339766023551, 6620.238672552526, 6629.5359324846795, 6645.036469711768, 6516.185476815398, 6579.671016449062, 6621.801345959629, 6625.304343043911, 6653.434458071119], "unit": "score", "name": "mootools.html", "value": 4557.048989468751}, {"lowerIsBetter": false, "replicates": [336.0824947892254, 336.87030493260096, 342.2641321159508, 346.4647120199293, 349.26305495404694, 6262.499000079994, 6264.373562643734, 6305.274893387262, 6329.0, 6419.422251997331, 6184.690765461732, 6301.621902685842, 6313.873722525546, 6332.3351048139975, 6336.619802811834, 4819.7590120494015, 4847.927281090787, 4859.635527335447, 4863.31913532104, 4869.5130486951375, 4865.221564549673, 4867.561919427251, 4876.780544875472, 4877.317175595419, 4881.438634557018, 4741.834035808747, 4839.080574690815, 4846.151923413407, 4847.806087756486, 4849.442314133885, 4782.115308667908, 4809.422869255694, 4822.373091498101, 4824.035192961422, 4835.709857408567, 4202.810873510669, 4204.222218889515, 4212.073343864345, 4224.640905523034, 4229.72506787061, 5888.5289176865745, 5976.61152025117, 6001.159837622693, 6015.0375939849855, 6015.939840601582, 5634.183043458716, 5661.122526008476, 5672.9432705672825, 5674.432556744334, 5678.063119585264, 6652.068710380502, 6711.295313992009, 6715.2613212546585, 6726.024726414691, 6733.259341472434, 4654.697444666086, 4672.299155126724, 4676.462206846189, 4686.835960741392, 4686.976565117153, 6879.690413931385, 6992.335728105771, 7000.439964802804, 7007.474439417064, 7024.297570242935, 4816.8073277069225, 4819.734914579732, 4821.710697358099, 4828.348172996671, 4828.686135401258, 4845.878853028632, 4850.514948505192, 4859.34398856157, 4866.659333846596, 4893.241547560134, 5504.697241651667, 5599.272094627672, 5606.299212598426, 5612.663240205601, 5614.747336369873, 6744.5616034957575, 6744.763933262312, 6753.1220941277315, 6767.695453704595, 6798.150231221098, 1636.8772342074392, 1679.529731675133, 1680.6218600814718, 1686.3591835102582, 1703.1654489300154, 1092.3937214845837, 1109.6560066379448, 1124.0951034417374, 1126.099120703434, 1133.7449073958294, 6086.6348019119, 6168.568200226031, 6197.4732147767045, 6257.186565746424, 6341.873162536724, 6820.0, 6825.112735344473, 6829.180498340231, 6830.282820303896, 6873.381395674413, 6095.1771510845465, 6252.093446450239, 6254.8123556293385, 6256.374362563707, 6277.843053923689, 3700.648438398348, 3718.6095459976314, 3739.3082279778328, 3739.9065023374087, 3742.214135031619, 7124.715011399486, 7148.606826624586, 7150.7497237596435, 7171.390431813355, 7172.677229524684, 6963.1296087989, 6965.930340696629, 6982.860342793218, 7000.264972177848, 7007.124109486314, 7222.205557388683, 7244.166920804069, 7270.382017528569, 7367.336939675455, 7389.889151662729, 7001.264867188872, 7001.404880585207, 7018.403435708022, 7036.8592628146125, 7050.717971281091, 6817.89773153413, 6897.172339319314, 6910.343517366044, 6915.481338899502, 6969.6515174242095, 7313.232110628307, 7323.560586364835, 7342.70629174827, 7354.411647068115, 7363.2268611797135, 4653.092646933816, 4674.742889140994, 4699.53004699541, 4707.317438971399, 4728.0, 6953.513254072166, 7066.04608377883, 7072.151341839012, 7074.257202993612, 7085.078939737801, 6722.092517510074, 6778.288279730557, 6802.829929251809, 6807.591544507345, 6820.727170913108, 6753.459723222229, 6783.18601767791, 6785.830354241183, 6799.0, 6812.965935170292, 6509.707063182073, 6655.800325990228, 6678.098456708476, 6679.23188833271, 6683.365080317362, 6838.452923765987, 6860.142482189726, 6864.553804002724, 6865.862682746218, 6881.759138430131, 6551.0, 6659.467242620675, 6686.0, 6698.162729658793, 6713.597184168965], "unit": "score", "name": "prototype.html", "value": 5063.979371643141}, {"lowerIsBetter": false, "replicates": [745.5414919824308, 820.8932838730964, 840.4285086141422, 851.808343122797, 878.1131057631792, 12047.518099276029, 12072.275663460177, 12148.27110373376, 12154.270743755369, 12240.81638775418, 12228.144029917887, 12323.445444954976, 12389.070819688537, 12463.626091217255, 12734.0, 803.0884945586772, 816.94281400302, 818.5007145641155, 819.4714409206058, 820.0405525535139, 791.0428381658201, 798.1858504325585, 798.6805277888833, 798.7723498802842, 801.8115742800437, 849.3502470609989, 849.5072857742495, 853.3727710133047, 853.8420392227458, 854.0221446443818, 847.7838151271447, 853.5561508015859, 856.0326830681353, 857.0358346859783, 857.8841856349406, 627.4509803921569, 627.7175271127965, 627.9560430769848, 628.4030171337203, 629.9338569450233, 12666.620001399973, 12681.175723577939, 12711.173773704772, 12716.300603466805, 12731.427085781163, 10619.20355973305, 10785.5685772569, 10965.067969222626, 10989.945050274777, 11394.088472922147, 9673.419594824263, 9775.951120244425, 9802.754931126708, 9814.46020468874, 9831.754206144831, 3400.9659903401143, 3509.6841284284283, 3522.982385088084, 3540.8760693375607, 3543.3976224041976, 41507.377389339184, 41578.79210603958, 43685.0, 45277.32084018776, 45486.31770523445, 9837.704868853803, 9842.114209721016, 9878.901210987799, 9983.450910199863, 10043.347182433265, 14751.336189871266, 14841.183734894468, 14872.479463218951, 14951.626209344637, 14969.775453368207, 7177.389921856597, 7210.67551960163, 7405.407567394595, 7434.145073316529, 7526.134494533198, 4089.7750623715983, 4108.609682080198, 4233.957660423418, 4307.935380969288, 4311.741295522279, 3162.98418507906, 3176.7140957313954, 3183.8567264473154, 3200.2639392939755, 3211.3737821124655, 559.4098226371217, 569.6582050769588, 580.2138102870634, 580.3847921203537, 580.7096451774113, 558.7178474870165, 583.8751496798552, 605.5821483176594, 636.4233010481125, 672.3881268046055, 8471.195236452528, 8901.599428025755, 8955.552222388986, 8956.841686555239, 8979.775505612412, 536.841631718644, 569.46754784276, 629.9527535434861, 632.4213344789466, 672.7779832655212, 3950.2889479893897, 3959.3862951242027, 4007.238624661305, 4018.9901764653355, 4106.938395924063, 54371.184432233546, 58122.7093864528, 58167.70916145477, 58232.41767582355, 58372.0, 46522.76738616353, 48530.5146948526, 50324.245136322985, 50900.490995089574, 51851.0, 44061.33907991383, 45225.09549808985, 45377.31934020992, 45650.0, 46049.30926036112, 8318.41771076043, 8404.20160084791, 8943.37396382247, 8953.776155596162, 8972.641094356413, 33920.66079339274, 34430.311393772485, 34714.65285347114, 35644.82177589095, 35665.28669426545, 40832.18335633211, 41515.7924210377, 41794.58205417907, 45908.0, 47045.76477117593, 10397.740056498647, 10461.26771126014, 10467.371957682564, 10585.0, 10591.20565957541, 10675.457320114241, 10744.844720496894, 10946.288491248044, 11060.612878549213, 11312.717182070513, 10604.469776510989, 10783.352998820095, 10813.729656758644, 10981.890181098086, 11006.339619622848, 10753.085987691135, 10818.849149911746, 11041.503132358903, 11061.336319820837, 11697.06423486136, 10802.567897284021, 10871.29336593119, 10998.175136864927, 11017.669469915916, 11548.191626586058, 8596.968363796384, 8633.30933525329, 8860.601272942604, 8965.955170224108, 9189.402688825205, 8293.917060829315, 8850.114988501098, 9069.319801014819, 9157.650695517976, 9178.449293042439], "unit": "score", "name": "yui.html", "value": 6089.253564344493}], "name": "dromaeo_css", "value": 6882.939662014659}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 113.0, 113.0, 112.0, 121.0, 114.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [156.0, 123.0, 150.0, 168.0, 124.0, 149.0, 163.0, 128.0, 164.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 163.0, 163.0, 164.0, 162.0, 160.0, 163.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 71.0, 75.0, 71.0, 144.0, 72.0, 71.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [94.0, 100.0, 140.0, 96.0, 97.0, 96.0, 139.0, 94.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 64.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 87.0, 87.0, 86.0, 88.0, 88.0, 87.0, 90.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [128.0, 134.0, 116.0, 124.0, 121.0, 134.0, 118.0, 130.0, 123.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [146.0, 158.0, 158.0, 158.0, 166.0, 143.0, 145.0, 145.0, 155.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 67.0, 67.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1522.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.47391749062393], "unit": "score", "name": "Richards", "value": 207.08153200000004}, {"lowerIsBetter": false, "replicates": [188.96447467876038], "unit": "score", "name": "DeltaBlue", "value": 349.896456}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [753.5795026375282], "unit": "score", "name": "Earley", "value": 884.3964010000001}, {"lowerIsBetter": false, "replicates": [12071.42857142857], "unit": "score", "name": "Boyer", "value": 55.209952662721896}, {"lowerIsBetter": false, "replicates": [42854.166666666664], "unit": "score", "name": "RegExp", "value": 21.257792902284876}, {"lowerIsBetter": false, "replicates": [589.9705014749262], "unit": "score", "name": "Splay", "value": 138.12724499999996}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20199.113582326656}]} 05:25:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20199.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1522.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6882.94"}}} 05:25:23 INFO - Return code: 0 05:25:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:25:23 INFO - # TBPL SUCCESS # 05:25:23 INFO - Running post-action listener: _resource_record_post_action 05:25:23 INFO - Running post-run listener: _resource_record_post_run 05:25:24 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 424980480; Read time: 0; Write time: 415804 05:25:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115195904; Read time: 0; Write time: 106696 05:25:24 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 308797440; Read time: 0; Write time: 308872 05:25:24 INFO - Running post-run listener: _upload_blobber_files 05:25:24 INFO - Blob upload gear active. 05:25:24 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:25:24 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:25:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:25:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:25:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:25 INFO - (blobuploader) - INFO - Done attempting. 05:25:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:26 INFO - (blobuploader) - INFO - Done attempting. 05:25:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:26 INFO - Return code: 0 05:25:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:25:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22419b5e70ba6656ae9e07b7503eff297f0fea8e9bc231d0e717017f151bcc820b789750dd4ff3f4ba9d68a9de762ee062f4d28534c90e8adbb5a5478220ca00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/230db3bdb6e7ba361220a2e5510915ff5570f42fa076b6347cb2eb71ce1314389ea871532753919c789ea4d0c4968e4f348612966cd86b3d68dce65360bebadc"} 05:25:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:25:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:25:26 INFO - Contents: 05:25:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22419b5e70ba6656ae9e07b7503eff297f0fea8e9bc231d0e717017f151bcc820b789750dd4ff3f4ba9d68a9de762ee062f4d28534c90e8adbb5a5478220ca00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/230db3bdb6e7ba361220a2e5510915ff5570f42fa076b6347cb2eb71ce1314389ea871532753919c789ea4d0c4968e4f348612966cd86b3d68dce65360bebadc"} 05:25:26 INFO - Copying logs to upload dir... 05:25:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1293.612903 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-12 05:25:25.076994) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:25.081939) ========= 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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22419b5e70ba6656ae9e07b7503eff297f0fea8e9bc231d0e717017f151bcc820b789750dd4ff3f4ba9d68a9de762ee062f4d28534c90e8adbb5a5478220ca00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/230db3bdb6e7ba361220a2e5510915ff5570f42fa076b6347cb2eb71ce1314389ea871532753919c789ea4d0c4968e4f348612966cd86b3d68dce65360bebadc"} build_url:https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/CKrssGa2Sk-0M8M39MBVag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22419b5e70ba6656ae9e07b7503eff297f0fea8e9bc231d0e717017f151bcc820b789750dd4ff3f4ba9d68a9de762ee062f4d28534c90e8adbb5a5478220ca00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/230db3bdb6e7ba361220a2e5510915ff5570f42fa076b6347cb2eb71ce1314389ea871532753919c789ea4d0c4968e4f348612966cd86b3d68dce65360bebadc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:25.109587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:25.109931) ========= 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=0274524eba3bdaad075c2247000001d4-1452602776.470542-1705463291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:25:25.190223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 05:25:25.193580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 05:25:25.193875) ========= ========= Total master_lag: 0.53 =========