builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1451463984.8 results: success (0) buildid: 20151229215656 builduid: a5e4892cef934b8fb5fcc64f348147ad revision: 77420c71e0d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.798963) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.799902) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.800219) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006283 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.854302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.854653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.899405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.899656) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.957307) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.957609) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.958020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.958294) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 00:26:25-- 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% 222M=0s 2015-12-30 00:26:25 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.137101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.137439) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020430 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.190597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.190959) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77420c71e0d4 --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 77420c71e0d4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 00:26:25,487 Setting DEBUG logging. 2015-12-30 00:26:25,487 attempt 1/10 2015-12-30 00:26:25,487 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77420c71e0d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 00:26:25,871 unpacking tar archive at: fx-team-77420c71e0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.862498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.862805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.877958) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.878233) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.878622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-30 00:26:25.878918) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:26:26 INFO - MultiFileLogger online at 20151230 00:26:26 in /builds/slave/test-pgo 00:26:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:26:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:26:26 INFO - {'append_to_log': False, 00:26:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:26:26 INFO - 'blob_upload_branch': 'Fx-Team', 00:26:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:26:26 INFO - 'branch': 'Fx-Team', 00:26:26 INFO - 'buildbot_json_path': 'buildprops.json', 00:26:26 INFO - 'config_files': ('talos/linux_config.py',), 00:26:26 INFO - 'default_actions': ('clobber', 00:26:26 INFO - 'read-buildbot-config', 00:26:26 INFO - 'download-and-extract', 00:26:26 INFO - 'populate-webroot', 00:26:26 INFO - 'create-virtualenv', 00:26:26 INFO - 'install', 00:26:26 INFO - 'run-tests'), 00:26:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:26:26 INFO - 'download_minidump_stackwalk': True, 00:26:26 INFO - 'download_symbols': 'ondemand', 00:26:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:26:26 INFO - 'tooltool.py': '/tools/tooltool.py', 00:26:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:26:26 INFO - '/tools/misc-python/virtualenv.py')}, 00:26:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:26:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:26:26 INFO - 'installer_path': 'installer.exe', 00:26:26 INFO - 'log_level': 'info', 00:26:26 INFO - 'log_name': 'talos', 00:26:26 INFO - 'log_to_console': True, 00:26:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:26:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:26:26 INFO - 'opt_config_files': (), 00:26:26 INFO - 'pip_index': False, 00:26:26 INFO - 'sps_profile': False, 00:26:26 INFO - 'sps_profile_interval': 0, 00:26:26 INFO - 'suite': 'dromaeojs', 00:26:26 INFO - 'system_bits': '32', 00:26:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:26:26 INFO - 'title': 'talos-linux64-ix-006', 00:26:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:26:26 INFO - 'use_talos_json': True, 00:26:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:26:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:26:26 INFO - 'work_dir': 'build'} 00:26:26 INFO - ##### 00:26:26 INFO - ##### Running clobber step. 00:26:26 INFO - ##### 00:26:26 INFO - Running pre-action listener: _resource_record_pre_action 00:26:26 INFO - Running main action method: clobber 00:26:26 INFO - rmtree: /builds/slave/test-pgo/build 00:26:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:26:27 INFO - Running post-action listener: _resource_record_post_action 00:26:27 INFO - ##### 00:26:27 INFO - ##### Running read-buildbot-config step. 00:26:27 INFO - ##### 00:26:27 INFO - Running pre-action listener: _resource_record_pre_action 00:26:27 INFO - Running main action method: read_buildbot_config 00:26:27 INFO - Using buildbot properties: 00:26:27 INFO - { 00:26:27 INFO - "project": "", 00:26:27 INFO - "product": "firefox", 00:26:27 INFO - "script_repo_revision": "production", 00:26:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:26:27 INFO - "repository": "", 00:26:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:26:27 INFO - "buildid": "20151229215656", 00:26:27 INFO - "pgo_build": "True", 00:26:27 INFO - "basedir": "/builds/slave/test-pgo", 00:26:27 INFO - "buildnumber": 858, 00:26:27 INFO - "slavename": "talos-linux64-ix-006", 00:26:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:26:27 INFO - "platform": "ubuntu64_hw", 00:26:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:26:27 INFO - "branch": "fx-team", 00:26:27 INFO - "repo_path": "integration/fx-team", 00:26:27 INFO - "revision": "77420c71e0d4", 00:26:27 INFO - "stage_platform": "linux64-pgo", 00:26:27 INFO - "builduid": "a5e4892cef934b8fb5fcc64f348147ad", 00:26:27 INFO - "slavebuilddir": "test" 00:26:27 INFO - } 00:26:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:26:27 INFO - Running post-action listener: _resource_record_post_action 00:26:27 INFO - ##### 00:26:27 INFO - ##### Running download-and-extract step. 00:26:27 INFO - ##### 00:26:27 INFO - Running pre-action listener: _resource_record_pre_action 00:26:27 INFO - Running main action method: download_and_extract 00:26:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:26:27 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')]} 00:26:27 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:26:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json 00:26:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json 00:26:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:26:28 INFO - Downloaded 1302 bytes. 00:26:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:26:28 INFO - Using the following test package requirements: 00:26:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:26:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:28 INFO - u'jsshell-linux-x86_64.zip'], 00:26:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:26:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:26:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:26:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:26:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:26:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:26:28 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')]} 00:26:28 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:30 INFO - Downloaded 23192440 bytes. 00:26:30 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 00:26:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:30 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 00:26:31 INFO - Return code: 0 00:26:31 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 00:26:31 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')]} 00:26:31 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:26:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:33 INFO - Downloaded 23192440 bytes. 00:26:33 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 00:26:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:33 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 00:26:34 INFO - Return code: 0 00:26: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')]} 00:26:34 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:35 INFO - Downloaded 11132285 bytes. 00:26:35 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 00:26:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:35 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 00:26:35 INFO - Return code: 0 00:26: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')]} 00:26:35 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:26:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/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 00:26:36 INFO - Downloaded 54896173 bytes. 00:26:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:36 INFO - mkdir: /builds/slave/test-pgo/properties 00:26:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:26:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:26:36 INFO - Contents: 00:26:36 INFO - build_url:https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:36 INFO - Running post-action listener: _resource_record_post_action 00:26:36 INFO - Running post-action listener: set_extra_try_arguments 00:26:36 INFO - ##### 00:26:36 INFO - ##### Running populate-webroot step. 00:26:36 INFO - ##### 00:26:36 INFO - Running pre-action listener: _resource_record_pre_action 00:26:36 INFO - Running main action method: populate_webroot 00:26:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:26:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:26:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:26:36 INFO - '--tppagecycles', 00:26:36 INFO - '7'], 00:26:36 INFO - 'tests': ['tsvgm']}}, 00:26:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:26:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:26:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:26:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:26:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'tests': ['damp', 'tps']}, 00:26:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['damp', 'tps']}, 00:26:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:26:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:26:36 INFO - 'other': {'tests': ['a11yr', 00:26:36 INFO - 'ts_paint', 00:26:36 INFO - 'tpaint', 00:26:36 INFO - 'sessionrestore', 00:26:36 INFO - 'sessionrestore_no_auto_restore']}, 00:26:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['a11yr', 00:26:36 INFO - 'ts_paint', 00:26:36 INFO - 'tpaint', 00:26:36 INFO - 'sessionrestore', 00:26:36 INFO - 'sessionrestore_no_auto_restore']}, 00:26:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['a11yr', 00:26:36 INFO - 'ts_paint', 00:26:36 INFO - 'tpaint', 00:26:36 INFO - 'sessionrestore', 00:26:36 INFO - 'sessionrestore_no_auto_restore']}, 00:26:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['a11yr', 00:26:36 INFO - 'ts_paint', 00:26:36 INFO - 'tpaint', 00:26:36 INFO - 'sessionrestore', 00:26:36 INFO - 'sessionrestore_no_auto_restore']}, 00:26:36 INFO - 'other_l64': {'tests': ['a11yr', 00:26:36 INFO - 'ts_paint', 00:26:36 INFO - 'tpaint', 00:26:36 INFO - 'sessionrestore', 00:26:36 INFO - 'sessionrestore_no_auto_restore']}, 00:26:36 INFO - 'other_nol64': {'tests': ['a11yr', 00:26:36 INFO - 'ts_paint', 00:26:36 INFO - 'tpaint', 00:26:36 INFO - 'sessionrestore', 00:26:36 INFO - 'sessionrestore_no_auto_restore']}, 00:26:36 INFO - 'svgr': {'tests': ['tsvgx', 00:26:36 INFO - 'tsvgr_opacity', 00:26:36 INFO - 'tart', 00:26:36 INFO - 'tscrollx', 00:26:36 INFO - 'cart']}, 00:26:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['tsvgx', 00:26:36 INFO - 'tsvgr_opacity', 00:26:36 INFO - 'tart', 00:26:36 INFO - 'tscrollx', 00:26:36 INFO - 'cart']}, 00:26:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'tests': ['tp5o']}, 00:26:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'talos_options': ['--e10s'], 00:26:36 INFO - 'tests': ['tp5o']}, 00:26:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'talos_options': ['--xperf_path', 00:26:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:36 INFO - 'tests': ['tp5n']}, 00:26:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:36 INFO - 'talos_options': ['--e10s', 00:26:36 INFO - '--xperf_path', 00:26:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:36 INFO - 'tests': ['tp5n']}}, 00:26:36 INFO - 'talos.zip': {'path': '', 00:26:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:26:36 INFO - Running post-action listener: _resource_record_post_action 00:26:36 INFO - ##### 00:26:36 INFO - ##### Running create-virtualenv step. 00:26:36 INFO - ##### 00:26:36 INFO - Running pre-action listener: _resource_record_pre_action 00:26:36 INFO - Running main action method: create_virtualenv 00:26:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:26:36 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 00:26:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:26:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:26:36 INFO - Using real prefix '/usr' 00:26:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:26:37 INFO - Installing distribute.............................................................................................................................................................................................done. 00:26:39 INFO - Installing pip.................done. 00:26:39 INFO - Return code: 0 00:26:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:26: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')]} 00:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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')]} 00:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:26: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 pip>=1.5 00:26:39 INFO - Using env: {'DISPLAY': ':0', 00:26:39 INFO - 'HOME': '/home/cltbld', 00:26:39 INFO - 'LANG': 'en_US.UTF-8', 00:26:39 INFO - 'LANGUAGE': 'en_US:en', 00:26:39 INFO - 'LOGNAME': 'cltbld', 00:26:39 INFO - 'MAIL': '/var/mail/cltbld', 00:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:39 INFO - 'MOZ_NO_REMOTE': '1', 00:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:39 INFO - 'NO_EM_RESTART': '1', 00:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:39 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:39 INFO - 'SHELL': '/bin/bash', 00:26:39 INFO - 'SHLVL': '1', 00:26:39 INFO - 'TERM': 'linux', 00:26:39 INFO - 'TMOUT': '86400', 00:26:39 INFO - 'USER': 'cltbld', 00:26:39 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:39 INFO - '_': '/tools/buildbot/bin/python'} 00:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:39 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 00:26:39 INFO - Cleaning up... 00:26:39 INFO - Return code: 0 00:26:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:26: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')]} 00:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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')]} 00:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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', '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 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:26: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 psutil>=0.7.1 00:26:39 INFO - Using env: {'DISPLAY': ':0', 00:26:39 INFO - 'HOME': '/home/cltbld', 00:26:39 INFO - 'LANG': 'en_US.UTF-8', 00:26:39 INFO - 'LANGUAGE': 'en_US:en', 00:26:39 INFO - 'LOGNAME': 'cltbld', 00:26:39 INFO - 'MAIL': '/var/mail/cltbld', 00:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:39 INFO - 'MOZ_NO_REMOTE': '1', 00:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:39 INFO - 'NO_EM_RESTART': '1', 00:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:39 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:39 INFO - 'SHELL': '/bin/bash', 00:26:39 INFO - 'SHLVL': '1', 00:26:39 INFO - 'TERM': 'linux', 00:26:39 INFO - 'TMOUT': '86400', 00:26:39 INFO - 'USER': 'cltbld', 00:26:39 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:39 INFO - '_': '/tools/buildbot/bin/python'} 00:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:39 INFO - Downloading/unpacking psutil>=0.7.1 00:26:39 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 00:26:39 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 00:26:39 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 00:26:39 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 00:26:39 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 00:26:39 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 00:26:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:26:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:26:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:26:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:41 INFO - Installing collected packages: psutil 00:26:41 INFO - Running setup.py install for psutil 00:26:41 INFO - building 'psutil._psutil_linux' extension 00:26:41 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 00:26:41 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 00:26:41 INFO - building 'psutil._psutil_posix' extension 00:26:41 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 00:26:41 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 00:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:42 INFO - Successfully installed psutil 00:26:42 INFO - Cleaning up... 00:26:42 INFO - Return code: 0 00:26:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:42 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 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26:42 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 00:26:42 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 00:26:42 INFO - Using env: {'DISPLAY': ':0', 00:26:42 INFO - 'HOME': '/home/cltbld', 00:26:42 INFO - 'LANG': 'en_US.UTF-8', 00:26:42 INFO - 'LANGUAGE': 'en_US:en', 00:26:42 INFO - 'LOGNAME': 'cltbld', 00:26:42 INFO - 'MAIL': '/var/mail/cltbld', 00:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:42 INFO - 'MOZ_NO_REMOTE': '1', 00:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:42 INFO - 'NO_EM_RESTART': '1', 00:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:42 INFO - 'SHELL': '/bin/bash', 00:26:42 INFO - 'SHLVL': '1', 00:26:42 INFO - 'TERM': 'linux', 00:26:42 INFO - 'TMOUT': '86400', 00:26:42 INFO - 'USER': 'cltbld', 00:26:42 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:42 INFO - '_': '/tools/buildbot/bin/python'} 00:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:26:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:26:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:26:44 INFO - Installing collected packages: mozsystemmonitor 00:26:44 INFO - Running setup.py install for mozsystemmonitor 00:26:44 INFO - Successfully installed mozsystemmonitor 00:26:44 INFO - Cleaning up... 00:26:44 INFO - Return code: 0 00:26:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:44 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 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26:44 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 00:26:44 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 00:26:44 INFO - Using env: {'DISPLAY': ':0', 00:26:44 INFO - 'HOME': '/home/cltbld', 00:26:44 INFO - 'LANG': 'en_US.UTF-8', 00:26:44 INFO - 'LANGUAGE': 'en_US:en', 00:26:44 INFO - 'LOGNAME': 'cltbld', 00:26:44 INFO - 'MAIL': '/var/mail/cltbld', 00:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:44 INFO - 'MOZ_NO_REMOTE': '1', 00:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:44 INFO - 'NO_EM_RESTART': '1', 00:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:44 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:44 INFO - 'SHELL': '/bin/bash', 00:26:44 INFO - 'SHLVL': '1', 00:26:44 INFO - 'TERM': 'linux', 00:26:44 INFO - 'TMOUT': '86400', 00:26:44 INFO - 'USER': 'cltbld', 00:26:44 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:44 INFO - '_': '/tools/buildbot/bin/python'} 00:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:44 INFO - Downloading/unpacking blobuploader==1.2.4 00:26:44 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 00:26:44 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 00:26:44 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 00:26:44 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 00:26:44 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 00:26:44 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 00:26:46 INFO - Downloading blobuploader-1.2.4.tar.gz 00:26:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:26:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:26:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:26:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:26:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 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 00:26:46 INFO - Downloading docopt-0.6.1.tar.gz 00:26:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:26:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:26:46 INFO - Installing collected packages: blobuploader, requests, docopt 00:26:46 INFO - Running setup.py install for blobuploader 00:26:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:26:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:26:47 INFO - Running setup.py install for requests 00:26:47 INFO - Running setup.py install for docopt 00:26:47 INFO - Successfully installed blobuploader requests docopt 00:26:47 INFO - Cleaning up... 00:26:47 INFO - Return code: 0 00:26:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:47 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 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26:47 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 00:26:47 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 00:26:47 INFO - Using env: {'DISPLAY': ':0', 00:26:47 INFO - 'HOME': '/home/cltbld', 00:26:47 INFO - 'LANG': 'en_US.UTF-8', 00:26:47 INFO - 'LANGUAGE': 'en_US:en', 00:26:47 INFO - 'LOGNAME': 'cltbld', 00:26:47 INFO - 'MAIL': '/var/mail/cltbld', 00:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:47 INFO - 'MOZ_NO_REMOTE': '1', 00:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:47 INFO - 'NO_EM_RESTART': '1', 00:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:47 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:47 INFO - 'SHELL': '/bin/bash', 00:26:47 INFO - 'SHLVL': '1', 00:26:47 INFO - 'TERM': 'linux', 00:26:47 INFO - 'TMOUT': '86400', 00:26:47 INFO - 'USER': 'cltbld', 00:26:47 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:47 INFO - '_': '/tools/buildbot/bin/python'} 00:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:26:47 INFO - Running setup.py (path:/tmp/pip-hK4xEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:26:47 INFO - Running setup.py (path:/tmp/pip-xylTF5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:26:47 INFO - Running setup.py (path:/tmp/pip-35ibgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:26:47 INFO - Running setup.py (path:/tmp/pip-RYvCz2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:26:48 INFO - Running setup.py (path:/tmp/pip-oMEH0Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:26:48 INFO - Running setup.py (path:/tmp/pip-ympL5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:26:48 INFO - Running setup.py (path:/tmp/pip-UEdvdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:26:48 INFO - Running setup.py (path:/tmp/pip-DF1vvF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:26:48 INFO - Running setup.py (path:/tmp/pip-y059Xh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:26:48 INFO - Running setup.py (path:/tmp/pip-SzZiuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:26:48 INFO - Running setup.py (path:/tmp/pip-SPrK7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:26:48 INFO - Running setup.py (path:/tmp/pip-A1eO4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:26:48 INFO - Running setup.py (path:/tmp/pip-TdypuX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:26:48 INFO - Running setup.py (path:/tmp/pip-4j6K7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:26:48 INFO - Running setup.py (path:/tmp/pip-hmL4o3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:26:48 INFO - Running setup.py (path:/tmp/pip-qLIK9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:26:48 INFO - Running setup.py (path:/tmp/pip-0bB7Zw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:26:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:26:48 INFO - Running setup.py install for manifestparser 00:26:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Running setup.py install for mozcrash 00:26:49 INFO - Running setup.py install for mozdebug 00:26:49 INFO - Running setup.py install for mozdevice 00:26:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Running setup.py install for mozfile 00:26:49 INFO - Running setup.py install for mozhttpd 00:26:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Running setup.py install for mozinfo 00:26:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Running setup.py install for mozInstall 00:26:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Running setup.py install for mozleak 00:26:49 INFO - Running setup.py install for mozlog 00:26:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:26:49 INFO - Running setup.py install for moznetwork 00:26:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:26:50 INFO - Running setup.py install for mozprocess 00:26:50 INFO - Running setup.py install for mozprofile 00:26:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:26:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:26:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:26:50 INFO - Running setup.py install for mozrunner 00:26:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:26:50 INFO - Running setup.py install for mozscreenshot 00:26:50 INFO - Running setup.py install for moztest 00:26:50 INFO - Running setup.py install for mozversion 00:26:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:26:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:26:50 INFO - Cleaning up... 00:26:50 INFO - Return code: 0 00:26:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:26: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')]} 00:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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')]} 00:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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/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 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26: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/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 00:26: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/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 00:26:50 INFO - Using env: {'DISPLAY': ':0', 00:26:50 INFO - 'HOME': '/home/cltbld', 00:26:50 INFO - 'LANG': 'en_US.UTF-8', 00:26:50 INFO - 'LANGUAGE': 'en_US:en', 00:26:50 INFO - 'LOGNAME': 'cltbld', 00:26:50 INFO - 'MAIL': '/var/mail/cltbld', 00:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:50 INFO - 'MOZ_NO_REMOTE': '1', 00:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:50 INFO - 'NO_EM_RESTART': '1', 00:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:50 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:50 INFO - 'SHELL': '/bin/bash', 00:26:50 INFO - 'SHLVL': '1', 00:26:50 INFO - 'TERM': 'linux', 00:26:50 INFO - 'TMOUT': '86400', 00:26:50 INFO - 'USER': 'cltbld', 00:26:50 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:50 INFO - '_': '/tools/buildbot/bin/python'} 00:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:26:50 INFO - Running setup.py (path:/tmp/pip-wWL6uw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:26:50 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)) 00:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:26:50 INFO - Running setup.py (path:/tmp/pip-WKWNHJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:26:51 INFO - Running setup.py (path:/tmp/pip-LSur5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:26:51 INFO - Running setup.py (path:/tmp/pip-uTGZ_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:26:51 INFO - Running setup.py (path:/tmp/pip-9aE94D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:26:51 INFO - Running setup.py (path:/tmp/pip-pGkyFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:26:51 INFO - Running setup.py (path:/tmp/pip-uGKTcu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:26:51 INFO - Running setup.py (path:/tmp/pip-b8Bt9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:26:51 INFO - Running setup.py (path:/tmp/pip-X_v3Dh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:26:51 INFO - Running setup.py (path:/tmp/pip-R_cmOu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:26:51 INFO - Running setup.py (path:/tmp/pip-ATRkBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:26:51 INFO - Running setup.py (path:/tmp/pip-5ZUbpx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:26:51 INFO - Running setup.py (path:/tmp/pip-LCEeMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:26:51 INFO - Running setup.py (path:/tmp/pip-BIOPPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:26:51 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)) 00:26:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:26:51 INFO - Running setup.py (path:/tmp/pip-aH0L3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:26:52 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)) 00:26:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:26:52 INFO - Running setup.py (path:/tmp/pip-NitwI1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:26:52 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)) 00:26:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:26:52 INFO - Running setup.py (path:/tmp/pip-1upWG9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:26:52 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)) 00:26:52 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)) 00:26:52 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)) 00:26:52 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)) 00:26:52 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)) 00:26:52 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)) 00:26:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:53 INFO - Downloading blessings-1.5.1.tar.gz 00:26:53 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 00:26:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:26:53 INFO - Installing collected packages: blessings 00:26:53 INFO - Running setup.py install for blessings 00:26:54 INFO - Successfully installed blessings 00:26:54 INFO - Cleaning up... 00:26:54 INFO - Return code: 0 00:26:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:26:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:26:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:26:54 INFO - Reading from file tmpfile_stdout 00:26:54 INFO - Current package versions: 00:26:54 INFO - argparse == 1.2.1 00:26:54 INFO - blessings == 1.5.1 00:26:54 INFO - blobuploader == 1.2.4 00:26:54 INFO - docopt == 0.6.1 00:26:54 INFO - manifestparser == 1.1 00:26:54 INFO - mozInstall == 1.12 00:26:54 INFO - mozcrash == 0.16 00:26:54 INFO - mozdebug == 0.1 00:26:54 INFO - mozdevice == 0.47 00:26:54 INFO - mozfile == 1.2 00:26:54 INFO - mozhttpd == 0.7 00:26:54 INFO - mozinfo == 0.9 00:26:54 INFO - mozleak == 0.1 00:26:54 INFO - mozlog == 3.1 00:26:54 INFO - moznetwork == 0.27 00:26:54 INFO - mozprocess == 0.22 00:26:54 INFO - mozprofile == 0.28 00:26:54 INFO - mozrunner == 6.11 00:26:54 INFO - mozscreenshot == 0.1 00:26:54 INFO - mozsystemmonitor == 0.0 00:26:54 INFO - moztest == 0.7 00:26:54 INFO - mozversion == 1.4 00:26:54 INFO - psutil == 3.1.1 00:26:54 INFO - requests == 1.2.3 00:26:54 INFO - wsgiref == 0.1.2 00:26:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26:54 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 00:26:54 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 00:26:54 INFO - Using env: {'DISPLAY': ':0', 00:26:54 INFO - 'HOME': '/home/cltbld', 00:26:54 INFO - 'LANG': 'en_US.UTF-8', 00:26:54 INFO - 'LANGUAGE': 'en_US:en', 00:26:54 INFO - 'LOGNAME': 'cltbld', 00:26:54 INFO - 'MAIL': '/var/mail/cltbld', 00:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:54 INFO - 'MOZ_NO_REMOTE': '1', 00:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:54 INFO - 'NO_EM_RESTART': '1', 00:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:54 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:54 INFO - 'SHELL': '/bin/bash', 00:26:54 INFO - 'SHLVL': '1', 00:26:54 INFO - 'TERM': 'linux', 00:26:54 INFO - 'TMOUT': '86400', 00:26:54 INFO - 'USER': 'cltbld', 00:26:54 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:54 INFO - '_': '/tools/buildbot/bin/python'} 00:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 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)) 00:26:54 INFO - Cleaning up... 00:26:54 INFO - Return code: 0 00:26:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 00:26:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:26:54 INFO - Using env: {'DISPLAY': ':0', 00:26:54 INFO - 'HOME': '/home/cltbld', 00:26:54 INFO - 'LANG': 'en_US.UTF-8', 00:26:54 INFO - 'LANGUAGE': 'en_US:en', 00:26:54 INFO - 'LOGNAME': 'cltbld', 00:26:54 INFO - 'MAIL': '/var/mail/cltbld', 00:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:54 INFO - 'MOZ_NO_REMOTE': '1', 00:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:54 INFO - 'NO_EM_RESTART': '1', 00:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:54 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:54 INFO - 'SHELL': '/bin/bash', 00:26:54 INFO - 'SHLVL': '1', 00:26:54 INFO - 'TERM': 'linux', 00:26:54 INFO - 'TMOUT': '86400', 00:26:54 INFO - 'USER': 'cltbld', 00:26:54 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:54 INFO - '_': '/tools/buildbot/bin/python'} 00:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:54 INFO - Downloading/unpacking jsonschema 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:26:56 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 00:26:56 INFO - Downloading/unpacking functools32 (from jsonschema) 00:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:56 INFO - Downloading functools32-3.2.3-2.tar.gz 00:26:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:26:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:26:56 INFO - warning: no files found matching '*.txt' 00:26:56 INFO - no previously-included directories found matching 'build' 00:26:56 INFO - no previously-included directories found matching 'dist' 00:26:56 INFO - no previously-included directories found matching '.git*' 00:26:56 INFO - Installing collected packages: jsonschema, functools32 00:26:56 INFO - Running setup.py install for functools32 00:26:56 INFO - warning: no files found matching '*.txt' 00:26:56 INFO - no previously-included directories found matching 'build' 00:26:56 INFO - no previously-included directories found matching 'dist' 00:26:56 INFO - no previously-included directories found matching '.git*' 00:26:56 INFO - Successfully installed jsonschema functools32 00:26:56 INFO - Cleaning up... 00:26:56 INFO - Return code: 0 00:26:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbd6744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', '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 00:26:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 00:26:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:26:56 INFO - Using env: {'DISPLAY': ':0', 00:26:56 INFO - 'HOME': '/home/cltbld', 00:26:56 INFO - 'LANG': 'en_US.UTF-8', 00:26:56 INFO - 'LANGUAGE': 'en_US:en', 00:26:56 INFO - 'LOGNAME': 'cltbld', 00:26:56 INFO - 'MAIL': '/var/mail/cltbld', 00:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:56 INFO - 'MOZ_NO_REMOTE': '1', 00:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:56 INFO - 'NO_EM_RESTART': '1', 00:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:56 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:56 INFO - 'SHELL': '/bin/bash', 00:26:56 INFO - 'SHLVL': '1', 00:26:56 INFO - 'TERM': 'linux', 00:26:56 INFO - 'TMOUT': '86400', 00:26:56 INFO - 'USER': 'cltbld', 00:26:56 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:56 INFO - '_': '/tools/buildbot/bin/python'} 00:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:57 INFO - Downloading/unpacking flake8 00:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:26:58 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 00:26:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:26:58 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 00:26:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:59 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 00:26:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:26:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:26:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:26:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:26:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:26:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:26:59 INFO - no previously-included directories found matching 'docs/_build' 00:26:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:26:59 INFO - Running setup.py install for pep8 00:26:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:26:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:26:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:26:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:26:59 INFO - no previously-included directories found matching 'docs/_build' 00:26:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:26:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:26:59 INFO - Cleaning up... 00:26:59 INFO - Return code: 0 00:26:59 INFO - Running post-action listener: _resource_record_post_action 00:26:59 INFO - Running post-action listener: _start_resource_monitoring 00:26:59 INFO - Starting resource monitoring. 00:26:59 INFO - ##### 00:26:59 INFO - ##### Running install step. 00:26:59 INFO - ##### 00:26:59 INFO - Running pre-action listener: _resource_record_pre_action 00:26:59 INFO - Running main action method: install 00:26:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:26:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:26:59 INFO - Reading from file tmpfile_stdout 00:26:59 INFO - Detecting whether we're running mozinstall >=1.0... 00:26:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:26:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:26:59 INFO - Reading from file tmpfile_stdout 00:26:59 INFO - Output received: 00:26:59 INFO - Usage: mozinstall [options] installer 00:26:59 INFO - Options: 00:26:59 INFO - -h, --help show this help message and exit 00:26:59 INFO - -d DEST, --destination=DEST 00:26:59 INFO - Directory to install application into. [default: 00:26:59 INFO - "/builds/slave/test-pgo"] 00:26:59 INFO - --app=APP Application being installed. [default: firefox] 00:26:59 INFO - mkdir: /builds/slave/test-pgo/build/application 00:26:59 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'] 00:26:59 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 00:27:15 INFO - Reading from file tmpfile_stdout 00:27:15 INFO - Output received: 00:27:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:27:15 INFO - Running post-action listener: _resource_record_post_action 00:27:15 INFO - ##### 00:27:15 INFO - ##### Running run-tests step. 00:27:15 INFO - ##### 00:27:15 INFO - Running pre-action listener: _resource_record_pre_action 00:27:15 INFO - Running main action method: run_tests 00:27:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:27:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:27:15 INFO - Python 2.7.3 00:27:15 INFO - Return code: 0 00:27:15 INFO - grabbing minidump binary from tooltool 00:27:15 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')]} 00:27:15 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 0x1657840>, '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 0x15c46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c4b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:27:15 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 00:27:15 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 00:27:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:27:15 INFO - Return code: 0 00:27:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:27:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:27:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:27:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:27:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:27:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:27:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:27:16 INFO - Return code: 0 00:27:16 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 00:27:16 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 00:27:16 INFO - Using env: {'DISPLAY': ':0', 00:27:16 INFO - 'HOME': '/home/cltbld', 00:27:16 INFO - 'LANG': 'en_US.UTF-8', 00:27:16 INFO - 'LANGUAGE': 'en_US:en', 00:27:16 INFO - 'LOGNAME': 'cltbld', 00:27:16 INFO - 'MAIL': '/var/mail/cltbld', 00:27:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:27:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:16 INFO - 'MOZ_NO_REMOTE': '1', 00:27:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:16 INFO - 'NO_EM_RESTART': '1', 00:27:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:27:16 INFO - 'PWD': '/builds/slave/test-pgo', 00:27:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:27:16 INFO - 'SHELL': '/bin/bash', 00:27:16 INFO - 'SHLVL': '1', 00:27:16 INFO - 'TERM': 'linux', 00:27:16 INFO - 'TMOUT': '86400', 00:27:16 INFO - 'USER': 'cltbld', 00:27:16 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442', 00:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:16 INFO - '_': '/tools/buildbot/bin/python'} 00:27:16 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:27:16 INFO - mozversion application_buildid: 20151229215656 00:27:16 INFO - mozversion application_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 00:27:16 INFO - mozversion application_display_name: Nightly 00:27:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:27:16 INFO - mozversion application_name: Firefox 00:27:16 INFO - mozversion application_remotingname: firefox 00:27:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:27:16 INFO - mozversion application_vendor: Mozilla 00:27:16 INFO - mozversion application_version: 46.0a1 00:27:16 INFO - mozversion platform_buildid: 20151229215656 00:27:16 INFO - mozversion platform_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 00:27:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:27:16 INFO - mozversion platform_version: 46.0a1 00:27:16 INFO - using testdate: 1451464036 00:27:16 INFO - actual date: 1451464036 00:27:16 INFO - starting webserver on 'localhost:53834' 00:27:16 INFO - SUITE-START | Running 3 tests 00:27:16 INFO - TEST-START | dromaeo_css 00:27:16 INFO - operating with platform_type : linux_ 00:27:16 INFO - Initialising browser for dromaeo_css test... 00:27:17 INFO - TEST-INFO | started process 1975 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDUofcd/profile http://localhost:53834/getInfo.html) 00:27:21 INFO - PROCESS | 1975 | __metrics Screen width/height:1600/1200 00:27:21 INFO - PROCESS | 1975 | colorDepth:24 00:27:21 INFO - PROCESS | 1975 | Browser inner width/height: 1024/697 00:27:21 INFO - PROCESS | 1975 | __metrics 00:27:21 INFO - PROCESS | 1975 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:27:21 INFO - PROCESS | 1975 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:27:21 INFO - PROCESS | 1975 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 00:27:22 INFO - TEST-INFO | 1975: exit 0 00:27:22 INFO - Browser initialized. 00:27:22 INFO - Running cycle 1/1 for dromaeo_css test... 00:27:22 INFO - TEST-INFO | started process 2067 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDUofcd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:27:33 INFO - PROCESS | 2067 | RSS: Main: 145948672 00:27:33 INFO - PROCESS | 2067 | 00:28:24 INFO - PROCESS | 2067 | 1451464104716 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] 00:30:34 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:53834/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53834/tests/dromaeo/cssquery-ext.html) 00:30:35 INFO - PROCESS | 2067 | RSS: Main: 256090112 00:30:35 INFO - PROCESS | 2067 | 00:33:37 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:53834/tests/dromaeo/cssquery-ext.html (next: http://localhost:53834/tests/dromaeo/cssquery-jquery.html) 00:33:38 INFO - PROCESS | 2067 | RSS: Main: 233455616 00:33:38 INFO - PROCESS | 2067 | 00:36:40 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:53834/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53834/tests/dromaeo/cssquery-mootools.html) 00:36:40 INFO - PROCESS | 2067 | RSS: Main: 231514112 00:36:40 INFO - PROCESS | 2067 | 00:39:42 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:53834/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53834/tests/dromaeo/cssquery-prototype.html) 00:39:43 INFO - PROCESS | 2067 | RSS: Main: 212832256 00:39:43 INFO - PROCESS | 2067 | 00:42:45 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:53834/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53834/tests/dromaeo/cssquery-yui.html) 00:42:46 INFO - PROCESS | 2067 | RSS: Main: 218492928 00:42:46 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:53834/tests/dromaeo/cssquery-yui.html (next: http://localhost:53834/tests/dromaeo/cssquery-dojo.html) 00:45:48 INFO - PROCESS | 2067 | RSS: Main: 265125888 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | __start_tp_report 00:45:48 INFO - PROCESS | 2067 | _x_x_mozilla_page_load 00:45:48 INFO - PROCESS | 2067 | _x_x_mozilla_page_load_details 00:45:48 INFO - PROCESS | 2067 | |i|pagename|runs| 00:45:48 INFO - PROCESS | 2067 | |0;dojo.html;3140.4190224808412;3201.4397480440916;3236.3203727217283;3245.513173024048;3269.3297873935844;5097.617678674105;5187.584993200544;5295.894082118355;5309.920351194735;5380.461953804617;5168.379794424674;5217.373915130181;5222.033923724104;5282.683039017662;5362.839114826552;4833.854984350475;4884.658073934817;4923.310736496894;4932.5807306379;4950.925736113961;4894.167991441445;4905.607551395879;4920.283812595799;4982.17794063979;5002.0246052019875;4925.605951523869;4931.284963680247;4975;4990.126727822635;5018.397792264915;4761.500042495557;4826.517348265145;4873.658843880929;4915;4926.655134140611;4778.1638213312535;4786.712797232142;4796.736179510125;4815.205491093965;4828.37231159947;5009.273655319958;5099.71951542665;5137.332146820927;5143.177091665316;5177.223416487519;5621.297337832771;5642.746076426571;5714.428557144294;5718.056520674084;5759.1937128802;5761.769529218868;5774.220480235156;5776.537876969833;5777.046787280094;5781.653100813965;5241.711705856214;5351.57187425005;5385.919211211835;5402.243685883979;5403.054465468566;5738.713064346766;5798.1302804579655;5875.735591898375;5883.058710606282;5884.735186916513;5624.85937851557;5624.887502249932;5625.099984002622;5625.578081643893;5696.3733989261145;5545.72271386429;5698.458646428583;5702.287214098238;5704;5707.086866101404;5565.805196818092;5576.832695019156;5630.915536266959;5642.351129620146;5663.518600918886;5622.437756224344;5661.66030038199;5668.688222147822;5676.262085928885;5676.375598684142;4372.715773474714;4408.206522825923;4416.116776644684;4423.734575925455;4460.174867649495;3912.902177445587;3956.7032472564674;3983.940240896389;3986.8405263789705;3992.0818211811447;5342.893142137135;5354.491323324278;5355.946440535623;5362.088444964365;5362.973185134128;5538.861528461821;5649.689267090267;5720.685362305113;5739.053056245756;5741.1388291756575;5212.061828870764;5287.9471205287455;5332.653377530448;5357.276767636319;5403.540699040625;4932.950670493249;4959.355283813081;4962.5533701967;4965.4289756678445;5006.849794506171;5675;5872.706364681663;5905.881882362329;5918.970405147947;5926.051831706906;5625.690587017753;5625.831225063254;5712.457316554921;5760.481556659921;5763.625364351304;5883.0881213411985;5886.293644762484;5887.293524777054;5890.587658863838;5890.852728681817;5477.315335583052;5603.691796951207;5606.327240731139;5609.24275222856;5619.466150715675;5587.832365029056;5597.496225339739;5649.37856835756;5775.393583673654;5789.9710501447225;5531.115021596525;5565.775529383529;5567.972160139336;5578.079616863334;5585.1901474286815;5514.779408823602;5571.1086226203615;5571.804986825442;5571.832845014656;5573.024720673785;5375.489328513785;5479.671219726829;5489.890202196014;5492.615516913777;5562.749676264497;5587.944120558743;5604.159376093618;5610.747516361692;5618.634788738719;5667.546596272371;5498;5503.559715222853;5505.779768809202;5506.201600767947;5509.972450137724 00:45:48 INFO - PROCESS | 2067 | |1;ext.html;542.6255883440426;546.6501439078987;563.3577721397605;602.5571205164204;606.4238972975672;27746.583801242974;28388.29029274269;28401;28432.004879829237;28474;28344.574831377548;28846.711532884667;39377.803110984474;40572.537020927746;40646.593534064654;8677.349198810083;8816.471011739317;8819.559022048872;8834.558272086402;8838;8460.069392366835;8599.570021498932;8600.096989816073;8600.956995215016;8605;7557.130929943072;7714.228577142297;10138.442385668784;10311.381317120959;10370.377777333384;9948.5523151458;10059.748506287327;10066.496675166212;10070.395776253448;10080.243981701366;7385.593792341419;7612.505187162817;9824.214062875024;9989.300748947577;9993.350432221954;39396.80301598473;40380.192396152204;40462;40490.19019619591;40507.39238911419;3122.3443076953868;3185.824779637119;3422.2299982503987;3630.6369363063745;3799.8480060797533;28656;29334.559981600294;30029.849850750827;30457.390852183053;30716.846415768003;3934.272159650474;3983.342748446503;4025.376066709665;4045.898852528681;4087;275779;275817;276351;276774.6161269201;276782;60980.39019609836;61334.69332653308;61489.69255153696;61520;61572.69213653903;64544.67727661425;64699.35300646933;64807.351926481075;64815.35184648093;64849.67575162094;15167.696646067017;15397.153156576496;15522.456714014956;15551.300191491184;15555.688886222211;11713.941430292964;11730.296182229093;11730.76538469243;11735.941320293345;11737.823932641017;19674.50813729668;19976.10107545164;20117.68058270369;20140.89929550343;20148.697769533468;7407.185209626937;7520.9623951880985;7680.654370553339;7708.075030996316;7734.7679569613;933.8700172790864;1027.7225149209671;1056.754580429657;1065.3927261461047;1080.9135269178446;28093;28266.010689625764;28612.570811437847;28686.856565717037;28920.276993075342;950.092661508258;962.2638681408728;976.7655762616921;1034.896510348959;1044.3264094658903;12420.937895310466;13750.449982000608;14206.289685515683;14392;14466.20435876037;512105;518820;521273;521753;675168;52864;53277.200841987404;53302.73348633232;53366.46633533615;53461.465385346426;1261.9684507887375;1265.1966001589058;1331.0948554982704;1333.0735139078247;1360.129517109051;29008.419831602827;30879.845600771852;30980.380392392475;33366.49950250797;33576.832115839265;42405.363919540614;49286.26070609016;49849;49945.25082123699;49953.50046499488;279782;304301;305843;306872;309463;38771.224575508895;39137.608623913395;39731.80134099311;39754.40368394534;39833;42317.576824231364;42563.1487370257;43231.567684324014;43517.564824352616;47181;38680.22639547137;38828.41757373698;39355.6064439352;39696.60303396929;40318.59681403149;33874.49188262227;38131.237375252895;38736.6126338733;39388.803055984536;40774.59225407708;34539.13652158716;34709.47935780915;38420;39640.80179599083;39667.801660991514;29601.5559766608;30931.690683092882;31974.840125799223;33017.50473742848;33917.321653567284;24545.631815522425;25360.619590706523;25548.361290967874;26099.869500652374;26197 00:45:48 INFO - PROCESS | 2067 | |2;jquery.html;350.30639334118445;351.19751368123843;353.9274448738009;354.37276021442034;354.88466248469246;14016.088954217968;14370.928145359285;16308.266128024237;16643.41748038819;17389.47831565052;15774.684506309866;16165.757513637276;16756.329746810112;16808.075555844425;16809.256696771787;5303.363596368441;5456.48163424476;5460.699661518614;5462.508374246317;5464.316960379952;3989.2221016901717;4095.4675892133982;4099.364598487239;4100.671946244308;5401;5798.420157984189;5936.3173235077875;5957.404259574051;5965.582409231356;5969.462748352647;5705.087186050233;5840.269966254218;5843.240378750777;5845.386234445365;5846.678432686222;5095.872603184913;5116.565091967187;5123.385193776733;5125.384953805567;5138.306328645623;12064.577739779066;12416.255024698547;19835.50411239716;20440.080196391198;20453.5909281815;2065.6281869263526;2067.1627990663806;2087.832973362127;2186.431527802767;2313.803326717231;9449.669261575811;9577.329586928918;9622.278329125344;11729.120315976335;11838.940805296004;1763.1536862306166;1792.6056267621102;1794.7577077094556;1837.6692195404821;1846.7783865936174;57654.42345576575;61112.388876111116;61251;61718.69140654313;61963.070553941725;9873.111419972238;10036;10063;10076.647317343857;10133.594656213816;13167.407466664023;13180.406881690347;13184.27486488233;13191.340432978313;13201.20792752438;7184.856302874018;7400.5189662671755;7401.222871598512;7434.256574342522;7473.290037446434;7232.457565682595;7238.493305468567;7272.309130632581;7304.233055529199;7327.853442931111;4155.646770024521;4215.0305429750715;4230.259704551691;4243.3634954757035;4331.805068771912;1729.662715770438;1759.7712297401513;1787.3833527433014;1798.5593529585335;1831.349870795875;924.630147940829;931.2038207332769;933.5425641435647;951.1582249709057;1029.912457441126;14462.566123016326;15394.15332156742;16007.519774406786;16253.51239462818;16575;901.3600343755876;935.0479187242871;940.2008292951074;941.7221919533754;989.2728844299434;9510.524473776284;9570.61717531291;9819.165370943407;9830.74055380368;9909.405435673883;522084;526532;538318;539300;543876;80971;82899.75650365249;83137.16862831415;84267.5786621063;86313;1134.6936327191777;1148.3683973814368;1149.8620165580185;1155.4107405223397;1176.2589568571916;14630.926845365704;15406.614834629225;15655.843441565894;15740;15762.842371576138;32696.83651581822;33110.337793244486;33265.667343326255;36260.274794503435;37019.62980370269;40723.38914916338;41490.3403863842;43035;43181.3522797152;44869.326960096274;9239.72280831576;9320.95339523298;9446.95276523613;9510.286728495528;9521.666741664008;13116.803247951097;16926.32294708198;16993;17276.049817260173;17679.469615911545;11705.707357316136;13904.721905562035;14048.086874353134;14144.717105657623;14310.427582896567;13090.214587124803;14294.356753946306;14368.497102601777;14383.424663013362;14680.486182983544;14314;14316.785248221076;14781.92609036948;15126.924365378103;15309.77035344493;9562.61749530011;9580.23358131334;9751.317407781387;9755.80488390214;9776.853347199656;10400.375977441377;13354.131981421177;14165.645858853612;14436;14598.635034124232 00:45:48 INFO - PROCESS | 2067 | |3;mootools.html;1298.9350532473375;1436.6336584171036;1436.7342041722281;1556.1596737761602;1756.1219390304848;6399.872002559951;7019.824504387393;7155.570665760058;7161.64191790411;7180.389666878308;6899.206591241996;7108.111486064242;7118.110236220473;7129.857402851952;7131.4651401144865;1918.290232613935;1961.744973153488;1962.5289930416668;2185.344396680993;2222.03341546427;2167.8916054197307;2218.1016688241207;2221.178164079293;2223.0552015393473;2225.354647152324;2152.0853637204127;2180.3349978256624;2226.743924448685;2228.565429741201;2229.598672238996;2171.576542574199;2178.7821217878163;2204.1954686539457;2206.7793220677963;2231.553689262154;2201.482651576878;2213.8118259947923;2229.9665505017438;2233.553289342122;2240.2271216430304;7109;7134.607596582186;7153.213146553875;7179.317964793337;7196.532225405332;4369.191699535564;4395.670324725658;4415.690901636886;4458;4459.0858873930765;2957.7190166934106;2976.851157442119;3008.9548656770166;3024.969750302491;3073;912.7261821453537;932.4871320773548;944.7449188719007;970.3110791338158;972.9708108756748;9616.51917404127;9645.614175432975;9661.130498255121;9662;9669.854952175723;3921.6470517653547;3957.3470377387407;4008.1382502762044;4014.8394064237687;4018.578049304781;8475.406721529434;8487;8487.278581320657;8492.74521764348;8497.065322814486;4464.553544645574;4495.1234509271035;4504.166729155117;4520.886977825515;4523.909521809611;4116.773577453268;4117.300058989919;4120.91758164835;4128.277551428488;4128.525219599785;3234;3285.0965984354493;3291.572095627601;3500.1249687578106;3524.559430071241;1026.8870424253325;1027;1090.6618948126106;1105.132471010253;1106.878243393226;996.4220751963844;998.605550807427;1052.0899421999916;1079.956801727922;1233.1306428967557;6661.034150048313;6667.733290668416;6695.46436285096;6711.664416779142;6713.765018224339;1089.0742868561817;1094.2996482251365;1098.6923661374828;1119.6137332620233;1121.7532142928542;5346;5415.160650099241;5426.511613954763;5435.537979271727;5439.211314359396;8188.14024527428;8269.8346033079;8324.417290789708;8385.664573416994;8427.452215605967;8310.376721745772;8313.584320783937;8316.417850750511;8317.708880189164;8320.043195032527;6731.394174524316;6831.385175334244;6873.965630171917;6876.9999999999;6947.89578156328;6772.390484856386;6827.556208846409;6834;6838.076859623887;6839.487038472234;7602.011738474184;7642.694292228471;7800.492967957065;7876.488028278143;7887.605619718876;7514.812129696801;7819.491733037335;7823.804404889924;7827.373810095065;8044.678212871654;6318.399752023551;6323.462505687068;6349.174607301022;6390.7763228286785;6416.679166041773;6205.875882482415;6876.449884009367;6903.482238832007;6916.757913473004;6917.13535808024;6031.849203769765;6300.842478938063;6538.476921846336;6550.6069635822005;6655.833604159935;6483.610983341015;6537.378948999837;6562.901556476561;6590.80227593173;6664.366885145903;6373.267074286517;6377.4579160771855;6381.93618063832;6542.149520562297;6584.341565843569;5896.410358964069;5941.257342832146;5946.07835785454;5946.672932988554;6016.5487588431915;6207.441330280297;6243.125962365363;6246.718897649525;6252.062190671436;6254.4996400286955 00:45:48 INFO - PROCESS | 2067 | |4;prototype.html;325.0459900192934;329.2296027296127;336;336.6616550366882;337.0159135324852;6062.605930614507;6072.8481787955325;6085.908711369333;6090.72591733372;6101.1153382759585;5927.110933359998;5957.970210148954;5976.19321391612;5992.131140984555;6021.9698901505435;4623.815047398117;4624.144533261349;4632.791524381394;4635.235186194274;4636.744979026153;4536.818527258905;4611.33135695324;4630.536946305359;4632.583067523922;4633.073385322932;4573.268277075668;4586.312053192031;4587.587117159455;4589.059242855224;4603.8158473661015;4374.58441448062;4579.38178345924;4582.587567118959;4594.862154135381;4600.608948239404;3875.418687196915;3917.5298964124204;3930.6612565523756;3933.0364060805;3941.605839416064;5681.7727290908315;5697.943020569783;5709.0580054290995;5727.656340619576;5742.569307301969;4986.800527978877;5076.898462030776;5144.6913185209005;5222.477752224785;5227.503387178212;6281.528885333618;6285.497160227171;6308.526860485482;6310.2427708674795;6313.715882785285;4326.545712700153;4327.069680018811;4332.631726303268;4334.284843000901;4339.891502712426;6475.093486911836;6606.438452731523;6609.107770450975;6610.041543976096;6610.173728283965;4438.201123797748;4446.977195245112;4448.977755111204;4449.57729015743;4450.020995381011;4495.280755079171;4502.549745025537;4503.144402563503;4505;4507.661925355612;5223.634345595848;5226.817061402832;5228.581713462914;5232.293640358503;5238.292830467838;6281.560290779602;6386.457151142112;6397.168368112116;6397.616143031433;6405.135306733625;1621.7243068678354;1641.564985278902;1642.5975635969025;1642.8110767261917;1643.5233782203265;1109.1016276815806;1109.2623405435295;1114.3982249585133;1130.909527237819;1134.5631931706187;6111.052786818051;6117.632942023492;6118.265808103056;6162.661053642003;6177.598456100339;6585.275619681831;6590.176227971504;6593.967030164818;6604.438622717027;6609.867802644017;5985.670788106609;6105.175801266861;6108.389161083856;6111.388861113853;6113.908291375633;3544.2379888324135;3571.5178450909316;3573.731970102253;3576.624454432299;3579.3557159711504;6820.386165245052;6850.3149685032095;6854.691538880762;6867.416269617039;6868.175818901764;6410.102585638015;6739.629320387426;6740.157480314961;6749.628770417674;6753.797386078426;6671.933280667228;6775.457963362919;6936.826579335557;6959.4432445404245;6972.372486476343;6569.080328753883;6624.768133115318;6639.834004149935;6647.933520664731;6657.7669781557415;6425.421712045938;6549.901751473636;6560.573562718408;6570.882949898624;6573.474122070318;6930.168379794457;6934;6940.757073502403;6941.652917354011;6947.444204463732;4481.395011673382;4487.932681009853;4490.348899409632;4492.685512014127;4496;6455.48356131499;6655.933440665725;6658.966705166443;6665.800025999228;6668.433183179484;6447.194100737408;6467.838304042437;6471.611703297817;6472.935270647234;6496.252930912817;6426.068220107964;6449.903251451138;6461.547691661539;6463.192100987377;6463.256725476443;6203.193584833943;6334.524910631629;6336.510919933719;6342.778002769881;6351.174347334817;6475.838104047437;6477.77327793525;6486.481081513562;6491.318411566717;6495.188101487314;6277.30949595535;6310.242770867341;6326.0510923360025;6332.810015699536;6342.112104305309 00:45:48 INFO - PROCESS | 2067 | |5;yui.html;729.8795698709713;748.3190296829886;784.333316680821;804.7164772188357;830.7134038756628;12346.62960111197;12615.495380184804;12647.55733549326;12681.809772853403;12720.109592328541;12163.391830408465;12265.448054837532;13585.388657510435;13769.518066867662;13789.241591712476;801.2228138705447;816.4692949582759;816.510093943635;816.7998840284139;817.2481317188201;677.1400321591576;688.270433340658;812.1147948735877;824.2664029014182;824.9298809601161;832.5046597274642;833.8457385383723;835.778518692547;841.1252297610478;842.0611018714151;697.2260790522516;714.3856283596103;826.8222332198576;828.7348048624442;829.7427797382801;616.6084536319424;620.8106527509108;625.9061140828867;627.2848952194502;627.8399008252912;11847.881521184763;11949.581764638197;11956;11972.940135299355;11986.820197697041;11160.386178760245;12015.158938874283;12088.33514156721;12396.81404778929;12479.50081996719;9897.257705672031;9964.750881227956;10016.599336026551;10051.396916185053;10939.234253602252;3524.3303772283184;3581.28374325136;3606.765560238576;3627.2201476682376;3649.069487280753;48069.75965120152;48146.27780583294;48781.26828097581;48955;48997.755011225076;9674.600678060795;9714.174295184988;9724.076212759777;9732.70801875945;9734.659286924923;17810;17834.910825446048;17850.19674114668;17863.46409607714;17902;7352.080989876265;7443;7635.427342949301;7668.731594394169;7737.613119344011;4206.621404073648;4298.720583162084;4327.956720432819;4414.073044660593;4437.733735975852;3073.4928736758184;3102.612173478315;3105.829179395155;3107.2231942014496;3110.626724792994;542.5767901037118;555.7693557173727;561.6882630140311;573.6128113523355;575.088484751665;486.75175660412737;504.50054446098096;546.0035435330537;603.3544107804607;607.1499900139839;7519.360854327334;7573;7620.3522700569965;7968.442209045427;8178.959105204436;532.8880935003692;536.3349446686082;545.3074595263993;565.172022986327;575.3326141675636;3481.669241422061;3681.1165320323466;3831;3876.7286289959434;3899.29812633723;56906;57028.71485642545;57229;57231.71384143052;60846.69576652088;44768.3284750729;45392.546074539496;46469;46569.06861862744;46825;45080;45416.77291613521;45754.54245457503;46417.7679111609;46926.76536617295;8185.672573097009;8356.331493480386;8420.536870472182;8426.578671066545;8694.956525217334;32056.67943320537;33500;33720;35839.104022399646;35865;42558.787206063775;44410.11179776322;45005;45709.77145114253;46939.530604693515;10109.292349535463;10151.748317919484;10260.435676037889;10365.585376584851;10483.790324193626;11550.59572914944;11553.537858485566;11588.362640054878;11797.76404471923;11841.407929603658;9723.124918757347;9967.601295948081;10020.64927727526;10029.648962286285;10064.043915827984;10698.839517407401;10717.142628589538;10911.290766100177;10974.725631859268;11188;7507.512011719221;9867.851982220416;10114.291999560255;10475.319104258198;10624.94738041104;8888.955555222183;8998.190162885372;9128.726138215865;9363.859542106738;9751.122398984126;8760;8764.78088047804;8869.68956086534;9196.35625506208;9603.231741460806 00:45:48 INFO - PROCESS | 2067 | __end_tp_report 00:45:48 INFO - PROCESS | 2067 | __start_cc_report 00:45:48 INFO - PROCESS | 2067 | _x_x_mozilla_cycle_collect,875 00:45:48 INFO - PROCESS | 2067 | __end_cc_report 00:45:48 INFO - PROCESS | 2067 | __startTimestamp1451465148938__endTimestamp 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | ------- Summary: start ------- 00:45:48 INFO - PROCESS | 2067 | Number of tests: 6 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | [#0] dojo.html Cycles:165 Average:5293.82 Median:5505.78 stddev:568.95 (10.3%) stddev-sans-first:545.04 00:45:48 INFO - PROCESS | 2067 | Values: 3140.4 3201.4 3236.3 3245.5 3269.3 5097.6 5187.6 5295.9 5309.9 5380.5 5168.4 5217.4 5222.0 5282.7 5362.8 4833.9 4884.7 4923.3 4932.6 4950.9 4894.2 4905.6 4920.3 4982.2 5002.0 4925.6 4931.3 4975.0 4990.1 5018.4 4761.5 4826.5 4873.7 4915.0 4926.7 4778.2 4786.7 4796.7 4815.2 4828.4 5009.3 5099.7 5137.3 5143.2 5177.2 5621.3 5642.7 5714.4 5718.1 5759.2 5761.8 5774.2 5776.5 5777.0 5781.7 5241.7 5351.6 5385.9 5402.2 5403.1 5738.7 5798.1 5875.7 5883.1 5884.7 5624.9 5624.9 5625.1 5625.6 5696.4 5545.7 5698.5 5702.3 5704.0 5707.1 5565.8 5576.8 5630.9 5642.4 5663.5 5622.4 5661.7 5668.7 5676.3 5676.4 4372.7 4408.2 4416.1 4423.7 4460.2 3912.9 3956.7 3983.9 3986.8 3992.1 5342.9 5354.5 5355.9 5362.1 5363.0 5538.9 5649.7 5720.7 5739.1 5741.1 5212.1 5287.9 5332.7 5357.3 5403.5 4933.0 4959.4 4962.6 4965.4 5006.8 5675.0 5872.7 5905.9 5919.0 5926.1 5625.7 5625.8 5712.5 5760.5 5763.6 5883.1 5886.3 5887.3 5890.6 5890.9 5477.3 5603.7 5606.3 5609.2 5619.5 5587.8 5597.5 5649.4 5775.4 5790.0 5531.1 5565.8 5568.0 5578.1 5585.2 5514.8 5571.1 5571.8 5571.8 5573.0 5375.5 5479.7 5489.9 5492.6 5562.7 5587.9 5604.2 5610.7 5618.6 5667.5 5498.0 5503.6 5505.8 5506.2 5510.0 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | [#1] ext.html Cycles:180 Average:53617.79 Median:38708.42 stddev:105777.72 (273.3%) stddev-sans-first:105999.39 00:45:48 INFO - PROCESS | 2067 | Values: 542.6 546.7 563.4 602.6 606.4 27746.6 28388.3 28401.0 28432.0 28474.0 28344.6 28846.7 39377.8 40572.5 40646.6 8677.3 8816.5 8819.6 8834.6 8838.0 8460.1 8599.6 8600.1 8601.0 8605.0 7557.1 7714.2 10138.4 10311.4 10370.4 9948.6 10059.7 10066.5 10070.4 10080.2 7385.6 7612.5 9824.2 9989.3 9993.4 39396.8 40380.2 40462.0 40490.2 40507.4 3122.3 3185.8 3422.2 3630.6 3799.8 28656.0 29334.6 30029.8 30457.4 30716.8 3934.3 3983.3 4025.4 4045.9 4087.0 275779.0 275817.0 276351.0 276774.6 276782.0 60980.4 61334.7 61489.7 61520.0 61572.7 64544.7 64699.4 64807.4 64815.4 64849.7 15167.7 15397.2 15522.5 15551.3 15555.7 11713.9 11730.3 11730.8 11735.9 11737.8 19674.5 19976.1 20117.7 20140.9 20148.7 7407.2 7521.0 7680.7 7708.1 7734.8 933.9 1027.7 1056.8 1065.4 1080.9 28093.0 28266.0 28612.6 28686.9 28920.3 950.1 962.3 976.8 1034.9 1044.3 12420.9 13750.4 14206.3 14392.0 14466.2 512105.0 518820.0 521273.0 521753.0 675168.0 52864.0 53277.2 53302.7 53366.5 53461.5 1262.0 1265.2 1331.1 1333.1 1360.1 29008.4 30879.8 30980.4 33366.5 33576.8 42405.4 49286.3 49849.0 49945.3 49953.5 279782.0 304301.0 305843.0 306872.0 309463.0 38771.2 39137.6 39731.8 39754.4 39833.0 42317.6 42563.1 43231.6 43517.6 47181.0 38680.2 38828.4 39355.6 39696.6 40318.6 33874.5 38131.2 38736.6 39388.8 40774.6 34539.1 34709.5 38420.0 39640.8 39667.8 29601.6 30931.7 31974.8 33017.5 33917.3 24545.6 25360.6 25548.4 26099.9 26197.0 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | [#2] jquery.html Cycles:180 Average:28481.14 Median:36639.95 stddev:87332.76 (238.4%) stddev-sans-first:87552.20 00:45:48 INFO - PROCESS | 2067 | Values: 350.3 351.2 353.9 354.4 354.9 14016.1 14370.9 16308.3 16643.4 17389.5 15774.7 16165.8 16756.3 16808.1 16809.3 5303.4 5456.5 5460.7 5462.5 5464.3 3989.2 4095.5 4099.4 4100.7 5401.0 5798.4 5936.3 5957.4 5965.6 5969.5 5705.1 5840.3 5843.2 5845.4 5846.7 5095.9 5116.6 5123.4 5125.4 5138.3 12064.6 12416.3 19835.5 20440.1 20453.6 2065.6 2067.2 2087.8 2186.4 2313.8 9449.7 9577.3 9622.3 11729.1 11838.9 1763.2 1792.6 1794.8 1837.7 1846.8 57654.4 61112.4 61251.0 61718.7 61963.1 9873.1 10036.0 10063.0 10076.6 10133.6 13167.4 13180.4 13184.3 13191.3 13201.2 7184.9 7400.5 7401.2 7434.3 7473.3 7232.5 7238.5 7272.3 7304.2 7327.9 4155.6 4215.0 4230.3 4243.4 4331.8 1729.7 1759.8 1787.4 1798.6 1831.3 924.6 931.2 933.5 951.2 1029.9 14462.6 15394.2 16007.5 16253.5 16575.0 901.4 935.0 940.2 941.7 989.3 9510.5 9570.6 9819.2 9830.7 9909.4 522084.0 526532.0 538318.0 539300.0 543876.0 80971.0 82899.8 83137.2 84267.6 86313.0 1134.7 1148.4 1149.9 1155.4 1176.3 14630.9 15406.6 15655.8 15740.0 15762.8 32696.8 33110.3 33265.7 36260.3 37019.6 40723.4 41490.3 43035.0 43181.4 44869.3 9239.7 9321.0 9447.0 9510.3 9521.7 13116.8 16926.3 16993.0 17276.0 17679.5 11705.7 13904.7 14048.1 14144.7 14310.4 13090.2 14294.4 14368.5 14383.4 14680.5 14314.0 14316.8 14781.9 15126.9 15309.8 9562.6 9580.2 9751.3 9755.8 9776.9 10400.4 13354.1 14165.6 14436.0 14598.6 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | [#3] mootools.html Cycles:180 Average:5057.35 Median:6309.62 stddev:2544.66 (40.3%) stddev-sans-first:2536.11 00:45:48 INFO - PROCESS | 2067 | Values: 1298.9 1436.6 1436.7 1556.2 1756.1 6399.9 7019.8 7155.6 7161.6 7180.4 6899.2 7108.1 7118.1 7129.9 7131.5 1918.3 1961.7 1962.5 2185.3 2222.0 2167.9 2218.1 2221.2 2223.1 2225.4 2152.1 2180.3 2226.7 2228.6 2229.6 2171.6 2178.8 2204.2 2206.8 2231.6 2201.5 2213.8 2230.0 2233.6 2240.2 7109.0 7134.6 7153.2 7179.3 7196.5 4369.2 4395.7 4415.7 4458.0 4459.1 2957.7 2976.9 3009.0 3025.0 3073.0 912.7 932.5 944.7 970.3 973.0 9616.5 9645.6 9661.1 9662.0 9669.9 3921.6 3957.3 4008.1 4014.8 4018.6 8475.4 8487.0 8487.3 8492.7 8497.1 4464.6 4495.1 4504.2 4520.9 4523.9 4116.8 4117.3 4120.9 4128.3 4128.5 3234.0 3285.1 3291.6 3500.1 3524.6 1026.9 1027.0 1090.7 1105.1 1106.9 996.4 998.6 1052.1 1080.0 1233.1 6661.0 6667.7 6695.5 6711.7 6713.8 1089.1 1094.3 1098.7 1119.6 1121.8 5346.0 5415.2 5426.5 5435.5 5439.2 8188.1 8269.8 8324.4 8385.7 8427.5 8310.4 8313.6 8316.4 8317.7 8320.0 6731.4 6831.4 6874.0 6877.0 6947.9 6772.4 6827.6 6834.0 6838.1 6839.5 7602.0 7642.7 7800.5 7876.5 7887.6 7514.8 7819.5 7823.8 7827.4 8044.7 6318.4 6323.5 6349.2 6390.8 6416.7 6205.9 6876.4 6903.5 6916.8 6917.1 6031.8 6300.8 6538.5 6550.6 6655.8 6483.6 6537.4 6562.9 6590.8 6664.4 6373.3 6377.5 6381.9 6542.1 6584.3 5896.4 5941.3 5946.1 5946.7 6016.5 6207.4 6243.1 6246.7 6252.1 6254.5 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | [#4] prototype.html Cycles:180 Average:5335.80 Median:6103.15 stddev:1621.74 (26.6%) stddev-sans-first:1582.08 00:45:48 INFO - PROCESS | 2067 | Values: 325.0 329.2 336.0 336.7 337.0 6062.6 6072.8 6085.9 6090.7 6101.1 5927.1 5958.0 5976.2 5992.1 6022.0 4623.8 4624.1 4632.8 4635.2 4636.7 4536.8 4611.3 4630.5 4632.6 4633.1 4573.3 4586.3 4587.6 4589.1 4603.8 4374.6 4579.4 4582.6 4594.9 4600.6 3875.4 3917.5 3930.7 3933.0 3941.6 5681.8 5697.9 5709.1 5727.7 5742.6 4986.8 5076.9 5144.7 5222.5 5227.5 6281.5 6285.5 6308.5 6310.2 6313.7 4326.5 4327.1 4332.6 4334.3 4339.9 6475.1 6606.4 6609.1 6610.0 6610.2 4438.2 4447.0 4449.0 4449.6 4450.0 4495.3 4502.5 4503.1 4505.0 4507.7 5223.6 5226.8 5228.6 5232.3 5238.3 6281.6 6386.5 6397.2 6397.6 6405.1 1621.7 1641.6 1642.6 1642.8 1643.5 1109.1 1109.3 1114.4 1130.9 1134.6 6111.1 6117.6 6118.3 6162.7 6177.6 6585.3 6590.2 6594.0 6604.4 6609.9 5985.7 6105.2 6108.4 6111.4 6113.9 3544.2 3571.5 3573.7 3576.6 3579.4 6820.4 6850.3 6854.7 6867.4 6868.2 6410.1 6739.6 6740.2 6749.6 6753.8 6671.9 6775.5 6936.8 6959.4 6972.4 6569.1 6624.8 6639.8 6647.9 6657.8 6425.4 6549.9 6560.6 6570.9 6573.5 6930.2 6934.0 6940.8 6941.7 6947.4 4481.4 4487.9 4490.3 4492.7 4496.0 6455.5 6655.9 6659.0 6665.8 6668.4 6447.2 6467.8 6471.6 6472.9 6496.3 6426.1 6449.9 6461.5 6463.2 6463.3 6203.2 6334.5 6336.5 6342.8 6351.2 6475.8 6477.8 6486.5 6491.3 6495.2 6277.3 6310.2 6326.1 6332.8 6342.1 00:45:48 INFO - PROCESS | 2067 | 00:45:48 INFO - PROCESS | 2067 | [#5] yui.html Cycles:180 Average:13347.26 Median:24316.51 stddev:15697.18 (64.6%) stddev-sans-first:15712.61 00:45:48 INFO - PROCESS | 2067 | Values: 729.9 748.3 784.3 804.7 830.7 12346.6 12615.5 12647.6 12681.8 12720.1 12163.4 12265.4 13585.4 13769.5 13789.2 801.2 816.5 816.5 816.8 817.2 677.1 688.3 812.1 824.3 824.9 832.5 833.8 835.8 841.1 842.1 697.2 714.4 826.8 828.7 829.7 616.6 620.8 625.9 627.3 627.8 11847.9 11949.6 11956.0 11972.9 11986.8 11160.4 12015.2 12088.3 12396.8 12479.5 9897.3 9964.8 10016.6 10051.4 10939.2 3524.3 3581.3 3606.8 3627.2 3649.1 48069.8 48146.3 48781.3 48955.0 48997.8 9674.6 9714.2 9724.1 9732.7 9734.7 17810.0 17834.9 17850.2 17863.5 17902.0 7352.1 7443.0 7635.4 7668.7 7737.6 4206.6 4298.7 4328.0 4414.1 4437.7 3073.5 3102.6 3105.8 3107.2 3110.6 542.6 555.8 561.7 573.6 575.1 486.8 504.5 546.0 603.4 607.1 7519.4 7573.0 7620.4 7968.4 8179.0 532.9 536.3 545.3 565.2 575.3 3481.7 3681.1 3831.0 3876.7 3899.3 56906.0 57028.7 57229.0 57231.7 60846.7 44768.3 45392.5 46469.0 46569.1 46825.0 45080.0 45416.8 45754.5 46417.8 46926.8 8185.7 8356.3 8420.5 8426.6 8695.0 32056.7 33500.0 33720.0 35839.1 35865.0 42558.8 44410.1 45005.0 45709.8 46939.5 10109.3 10151.7 10260.4 10365.6 10483.8 11550.6 11553.5 11588.4 11797.8 11841.4 9723.1 9967.6 10020.6 10029.6 10064.0 10698.8 10717.1 10911.3 10974.7 11188.0 7507.5 9867.9 10114.3 10475.3 10624.9 8889.0 8998.2 9128.7 9363.9 9751.1 8760.0 8764.8 8869.7 9196.4 9603.2 00:45:48 INFO - PROCESS | 2067 | -------- Summary: end -------- 00:45:48 INFO - PROCESS | 2067 | 00:45:49 INFO - TEST-INFO | 2067: exit 0 00:45:49 INFO - TEST-OK | dromaeo_css | took 1112651ms 00:45:49 INFO - TEST-START | kraken 00:45:49 INFO - operating with platform_type : linux_ 00:45:49 INFO - Initialising browser for kraken test... 00:45:49 INFO - TEST-INFO | started process 2257 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXwE1c4/profile http://localhost:53834/getInfo.html) 00:45:53 INFO - PROCESS | 2257 | __metrics Screen width/height:1600/1200 00:45:53 INFO - PROCESS | 2257 | colorDepth:24 00:45:53 INFO - PROCESS | 2257 | Browser inner width/height: 1024/697 00:45:53 INFO - PROCESS | 2257 | __metrics 00:45:53 INFO - PROCESS | 2257 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:45:53 INFO - PROCESS | 2257 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:45:54 INFO - TEST-INFO | 2257: exit 0 00:45:54 INFO - Browser initialized. 00:45:54 INFO - Running cycle 1/1 for kraken test... 00:45:54 INFO - TEST-INFO | started process 2338 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXwE1c4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:46:06 INFO - PROCESS | 2338 | RSS: Main: 149487616 00:46:06 INFO - PROCESS | 2338 | 00:46:08 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53834/tests/kraken/driver.html?testName=audio-beat-detection) 00:46:09 INFO - PROCESS | 2338 | RSS: Main: 183803904 00:46:09 INFO - PROCESS | 2338 | 00:46:11 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53834/tests/kraken/driver.html?testName=audio-dft) 00:46:12 INFO - PROCESS | 2338 | RSS: Main: 174927872 00:46:12 INFO - PROCESS | 2338 | 00:46:15 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53834/tests/kraken/driver.html?testName=audio-fft) 00:46:16 INFO - PROCESS | 2338 | RSS: Main: 159903744 00:46:16 INFO - PROCESS | 2338 | 00:46:18 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53834/tests/kraken/driver.html?testName=audio-oscillator) 00:46:18 INFO - PROCESS | 2338 | RSS: Main: 162492416 00:46:18 INFO - PROCESS | 2338 | 00:46:20 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53834/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:46:21 INFO - PROCESS | 2338 | RSS: Main: 164864000 00:46:21 INFO - PROCESS | 2338 | 00:46:24 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53834/tests/kraken/driver.html?testName=imaging-darkroom) 00:46:24 INFO - PROCESS | 2338 | RSS: Main: 164155392 00:46:24 INFO - PROCESS | 2338 | 00:46:28 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53834/tests/kraken/driver.html?testName=imaging-desaturate) 00:46:28 INFO - PROCESS | 2338 | RSS: Main: 164376576 00:46:28 INFO - PROCESS | 2338 | 00:46:31 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53834/tests/kraken/driver.html?testName=json-parse-financial) 00:46:32 INFO - PROCESS | 2338 | RSS: Main: 164798464 00:46:32 INFO - PROCESS | 2338 | 00:46:33 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53834/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:46:34 INFO - PROCESS | 2338 | RSS: Main: 176660480 00:46:34 INFO - PROCESS | 2338 | 00:46:36 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:46:36 INFO - PROCESS | 2338 | RSS: Main: 174264320 00:46:36 INFO - PROCESS | 2338 | 00:46:38 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:46:39 INFO - PROCESS | 2338 | RSS: Main: 182804480 00:46:39 INFO - PROCESS | 2338 | 00:46:41 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:46:42 INFO - PROCESS | 2338 | RSS: Main: 192172032 00:46:42 INFO - PROCESS | 2338 | 00:46:44 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:46:45 INFO - PROCESS | 2338 | RSS: Main: 189657088 00:46:45 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:53834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53834/tests/kraken/driver.html?testName=ai-astar) 00:46:47 INFO - PROCESS | 2338 | RSS: Main: 247906304 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | __start_tp_report 00:46:47 INFO - PROCESS | 2338 | _x_x_mozilla_page_load 00:46:47 INFO - PROCESS | 2338 | _x_x_mozilla_page_load_details 00:46:47 INFO - PROCESS | 2338 | |i|pagename|runs| 00:46:47 INFO - PROCESS | 2338 | |0;ai-astar;110;111;106;112;111;110;99;109;109;101 00:46:47 INFO - PROCESS | 2338 | |1;audio-beat-detection;153;125;146;170;125;155;151;127;169;124 00:46:47 INFO - PROCESS | 2338 | |2;audio-dft;161;162;161;164;162;161;160;160;162;161 00:46:47 INFO - PROCESS | 2338 | |3;audio-fft;75;72;79;96;74;73;71;119;89;73 00:46:47 INFO - PROCESS | 2338 | |4;audio-oscillator;96;97;147;95;97;96;140;94;96;141 00:46:47 INFO - PROCESS | 2338 | |5;imaging-gaussian-blur;108;109;110;110;109;109;109;109;110;108 00:46:47 INFO - PROCESS | 2338 | |6;imaging-darkroom;146;144;147;145;145;147;147;146;146;147 00:46:47 INFO - PROCESS | 2338 | |7;imaging-desaturate;95;96;96;96;95;95;96;96;96;96 00:46:47 INFO - PROCESS | 2338 | |8;json-parse-financial;60;59;59;57;58;58;59;68;56;57 00:46:47 INFO - PROCESS | 2338 | |9;json-stringify-tinderbox;68;68;68;68;68;68;69;67;68;68 00:46:47 INFO - PROCESS | 2338 | |10;stanford-crypto-aes;87;86;89;86;93;85;85;86;87;87 00:46:47 INFO - PROCESS | 2338 | |11;stanford-crypto-ccm;124;117;129;115;120;124;120;119;127;117 00:46:47 INFO - PROCESS | 2338 | |12;stanford-crypto-pbkdf2;139;152;149;152;150;140;154;152;149;139 00:46:47 INFO - PROCESS | 2338 | |13;stanford-crypto-sha256-iterative;66;70;69;69;67;67;66;67;68;68 00:46:47 INFO - PROCESS | 2338 | __end_tp_report 00:46:47 INFO - PROCESS | 2338 | __start_cc_report 00:46:47 INFO - PROCESS | 2338 | _x_x_mozilla_cycle_collect,921 00:46:47 INFO - PROCESS | 2338 | __end_cc_report 00:46:47 INFO - PROCESS | 2338 | __startTimestamp1451465207365__endTimestamp 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | ------- Summary: start ------- 00:46:47 INFO - PROCESS | 2338 | Number of tests: 14 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.50 stddev:4.44 (4.0%) stddev-sans-first:4.64 00:46:47 INFO - PROCESS | 2338 | Values: 110.0 111.0 106.0 112.0 111.0 110.0 99.0 109.0 109.0 101.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:152.00 stddev:18.15 (11.9%) stddev-sans-first:18.99 00:46:47 INFO - PROCESS | 2338 | Values: 153.0 125.0 146.0 170.0 125.0 155.0 151.0 127.0 169.0 124.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 00:46:47 INFO - PROCESS | 2338 | Values: 161.0 162.0 161.0 164.0 162.0 161.0 160.0 160.0 162.0 161.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:15.34 (20.6%) stddev-sans-first:16.06 00:46:47 INFO - PROCESS | 2338 | Values: 75.0 72.0 79.0 96.0 74.0 73.0 71.0 119.0 89.0 73.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:22.70 (23.6%) stddev-sans-first:23.51 00:46:47 INFO - PROCESS | 2338 | Values: 96.0 97.0 147.0 95.0 97.0 96.0 140.0 94.0 96.0 141.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 00:46:47 INFO - PROCESS | 2338 | Values: 108.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 108.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 00:46:47 INFO - PROCESS | 2338 | Values: 146.0 144.0 147.0 145.0 145.0 147.0 147.0 146.0 146.0 147.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 00:46:47 INFO - PROCESS | 2338 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:3.35 (5.7%) stddev-sans-first:3.54 00:46:47 INFO - PROCESS | 2338 | Values: 60.0 59.0 59.0 57.0 58.0 58.0 59.0 68.0 56.0 57.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 00:46:47 INFO - PROCESS | 2338 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 69.0 67.0 68.0 68.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.38 (2.7%) stddev-sans-first:2.52 00:46:47 INFO - PROCESS | 2338 | Values: 87.0 86.0 89.0 86.0 93.0 85.0 85.0 86.0 87.0 87.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.00 stddev:4.61 (3.8%) stddev-sans-first:4.78 00:46:47 INFO - PROCESS | 2338 | Values: 124.0 117.0 129.0 115.0 120.0 124.0 120.0 119.0 127.0 117.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:151.00 stddev:5.91 (3.9%) stddev-sans-first:5.39 00:46:47 INFO - PROCESS | 2338 | Values: 139.0 152.0 149.0 152.0 150.0 140.0 154.0 152.0 149.0 139.0 00:46:47 INFO - PROCESS | 2338 | 00:46:47 INFO - PROCESS | 2338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.27 00:46:47 INFO - PROCESS | 2338 | Values: 66.0 70.0 69.0 69.0 67.0 67.0 66.0 67.0 68.0 68.0 00:46:47 INFO - PROCESS | 2338 | -------- Summary: end -------- 00:46:47 INFO - PROCESS | 2338 | 00:46:48 INFO - TEST-INFO | 2338: exit 0 00:46:48 INFO - TEST-OK | kraken | took 58604ms 00:46:48 INFO - TEST-START | v8_7 00:46:48 INFO - operating with platform_type : linux_ 00:46:48 INFO - Initialising browser for v8_7 test... 00:46:48 INFO - TEST-INFO | started process 2676 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkS10tZ/profile http://localhost:53834/getInfo.html) 00:46:52 INFO - PROCESS | 2676 | __metrics Screen width/height:1600/1200 00:46:52 INFO - PROCESS | 2676 | colorDepth:24 00:46:52 INFO - PROCESS | 2676 | Browser inner width/height: 1024/697 00:46:52 INFO - PROCESS | 2676 | __metrics 00:46:52 INFO - PROCESS | 2676 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:46:52 INFO - PROCESS | 2676 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:46:53 INFO - TEST-INFO | 2676: exit 0 00:46:53 INFO - Browser initialized. 00:46:53 INFO - Running cycle 1/1 for v8_7 test... 00:46:53 INFO - TEST-INFO | started process 2837 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkS10tZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:47:05 INFO - PROCESS | 2837 | RSS: Main: 148664320 00:47:05 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | Cycle 1(1): loaded http://localhost:53834/tests/v8_7/run.html (next: http://localhost:53834/tests/v8_7/run.html) 00:47:26 INFO - PROCESS | 2837 | RSS: Main: 615702528 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | __start_tp_report 00:47:26 INFO - PROCESS | 2837 | _x_x_mozilla_page_load 00:47:26 INFO - PROCESS | 2837 | _x_x_mozilla_page_load_details 00:47:26 INFO - PROCESS | 2837 | |i|pagename|runs| 00:47:26 INFO - PROCESS | 2837 | |0;Richards;167.22408026755852 00:47:26 INFO - PROCESS | 2837 | |1;DeltaBlue;191.64430816404752 00:47:26 INFO - PROCESS | 2837 | |2;Encrypt;282.326369282891 00:47:26 INFO - PROCESS | 2837 | |3;Decrypt;5251.308900523561 00:47:26 INFO - PROCESS | 2837 | |4;RayTrace;1982.1782178217823 00:47:26 INFO - PROCESS | 2837 | |5;Earley;809.0614886731391 00:47:26 INFO - PROCESS | 2837 | |6;Boyer;12144.578313253012 00:47:26 INFO - PROCESS | 2837 | |7;RegExp;25475 00:47:26 INFO - PROCESS | 2837 | |8;Splay;641.025641025641 00:47:26 INFO - PROCESS | 2837 | |9;NavierStokes;4817.307692307692 00:47:26 INFO - PROCESS | 2837 | __end_tp_report 00:47:26 INFO - PROCESS | 2837 | __startTimestamp1451465246678__endTimestamp 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | ------- Summary: start ------- 00:47:26 INFO - PROCESS | 2837 | Number of tests: 10 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 167.2 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#1] DeltaBlue Cycles:1 Average:191.64 Median:191.64 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 191.6 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#2] Encrypt Cycles:1 Average:282.33 Median:282.33 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 282.3 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 5251.3 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 1982.2 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#5] Earley Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 809.1 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 12144.6 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 25475.0 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#8] Splay Cycles:1 Average:641.03 Median:641.03 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 641.0 00:47:26 INFO - PROCESS | 2837 | 00:47:26 INFO - PROCESS | 2837 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 00:47:26 INFO - PROCESS | 2837 | Values: 4817.3 00:47:26 INFO - PROCESS | 2837 | -------- Summary: end -------- 00:47:26 INFO - PROCESS | 2837 | 00:47:27 INFO - TEST-INFO | 2837: exit 0 00:47:27 INFO - TEST-OK | v8_7 | took 39325ms 00:47:27 INFO - SUITE-END | took 1210s 00:47:27 INFO - Completed test suite (00:20:10) 00:47:27 INFO - Working with test: dromaeo_css 00:47:27 INFO - Generating results file: dromaeo_css 00:47:27 INFO - Working with test: kraken 00:47:27 INFO - Generating results file: kraken 00:47:27 INFO - javascript benchmark 00:47:27 INFO - Working with test: v8_7 00:47:27 INFO - Generating results file: v8_7 00:47:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 00:47:27 INFO - process_Request line: dromaeo_css 6880.26 graph.html#tests=[[72,64,35]] 00:47:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:27 INFO - process_Request line: kraken 1507.20 graph.html#tests=[[232,64,35]] 00:47:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:27 INFO - process_Request line: v8_7 19641.33 graph.html#tests=[[230,64,35]] 00:47:27 INFO - RETURN: dromaeo_css: 6880.26 00:47:27 INFO - RETURN: kraken: 1507.20 00:47:27 INFO - RETURN: v8_7: 19641.33 00:47:27 INFO - javascript benchmark 00:47:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3140.4190224808412, 3201.4397480440916, 3236.3203727217283, 3245.513173024048, 3269.3297873935844, 5097.617678674105, 5187.584993200544, 5295.894082118355, 5309.920351194735, 5380.461953804617, 5168.379794424674, 5217.373915130181, 5222.033923724104, 5282.683039017662, 5362.839114826552, 4833.854984350475, 4884.658073934817, 4923.310736496894, 4932.5807306379, 4950.925736113961, 4894.167991441445, 4905.607551395879, 4920.283812595799, 4982.17794063979, 5002.0246052019875, 4925.605951523869, 4931.284963680247, 4975.0, 4990.126727822635, 5018.397792264915, 4761.500042495557, 4826.517348265145, 4873.658843880929, 4915.0, 4926.655134140611, 4778.1638213312535, 4786.712797232142, 4796.736179510125, 4815.205491093965, 4828.37231159947, 5009.273655319958, 5099.71951542665, 5137.332146820927, 5143.177091665316, 5177.223416487519, 5621.297337832771, 5642.746076426571, 5714.428557144294, 5718.056520674084, 5759.1937128802, 5761.769529218868, 5774.220480235156, 5776.537876969833, 5777.046787280094, 5781.653100813965, 5241.711705856214, 5351.57187425005, 5385.919211211835, 5402.243685883979, 5403.054465468566, 5738.713064346766, 5798.1302804579655, 5875.735591898375, 5883.058710606282, 5884.735186916513, 5624.85937851557, 5624.887502249932, 5625.099984002622, 5625.578081643893, 5696.3733989261145, 5545.72271386429, 5698.458646428583, 5702.287214098238, 5704.0, 5707.086866101404, 5565.805196818092, 5576.832695019156, 5630.915536266959, 5642.351129620146, 5663.518600918886, 5622.437756224344, 5661.66030038199, 5668.688222147822, 5676.262085928885, 5676.375598684142, 4372.715773474714, 4408.206522825923, 4416.116776644684, 4423.734575925455, 4460.174867649495, 3912.902177445587, 3956.7032472564674, 3983.940240896389, 3986.8405263789705, 3992.0818211811447, 5342.893142137135, 5354.491323324278, 5355.946440535623, 5362.088444964365, 5362.973185134128, 5538.861528461821, 5649.689267090267, 5720.685362305113, 5739.053056245756, 5741.1388291756575, 5212.061828870764, 5287.9471205287455, 5332.653377530448, 5357.276767636319, 5403.540699040625, 4932.950670493249, 4959.355283813081, 4962.5533701967, 4965.4289756678445, 5006.849794506171, 5675.0, 5872.706364681663, 5905.881882362329, 5918.970405147947, 5926.051831706906, 5625.690587017753, 5625.831225063254, 5712.457316554921, 5760.481556659921, 5763.625364351304, 5883.0881213411985, 5886.293644762484, 5887.293524777054, 5890.587658863838, 5890.852728681817, 5477.315335583052, 5603.691796951207, 5606.327240731139, 5609.24275222856, 5619.466150715675, 5587.832365029056, 5597.496225339739, 5649.37856835756, 5775.393583673654, 5789.9710501447225, 5531.115021596525, 5565.775529383529, 5567.972160139336, 5578.079616863334, 5585.1901474286815, 5514.779408823602, 5571.1086226203615, 5571.804986825442, 5571.832845014656, 5573.024720673785, 5375.489328513785, 5479.671219726829, 5489.890202196014, 5492.615516913777, 5562.749676264497, 5587.944120558743, 5604.159376093618, 5610.747516361692, 5618.634788738719, 5667.546596272371, 5498.0, 5503.559715222853, 5505.779768809202, 5506.201600767947, 5509.972450137724], "unit": "score", "name": "dojo.html", "value": 5258.13361071861}, {"lowerIsBetter": false, "replicates": [542.6255883440426, 546.6501439078987, 563.3577721397605, 602.5571205164204, 606.4238972975672, 27746.583801242974, 28388.29029274269, 28401.0, 28432.004879829237, 28474.0, 28344.574831377548, 28846.711532884667, 39377.803110984474, 40572.537020927746, 40646.593534064654, 8677.349198810083, 8816.471011739317, 8819.559022048872, 8834.558272086402, 8838.0, 8460.069392366835, 8599.570021498932, 8600.096989816073, 8600.956995215016, 8605.0, 7557.130929943072, 7714.228577142297, 10138.442385668784, 10311.381317120959, 10370.377777333384, 9948.5523151458, 10059.748506287327, 10066.496675166212, 10070.395776253448, 10080.243981701366, 7385.593792341419, 7612.505187162817, 9824.214062875024, 9989.300748947577, 9993.350432221954, 39396.80301598473, 40380.192396152204, 40462.0, 40490.19019619591, 40507.39238911419, 3122.3443076953868, 3185.824779637119, 3422.2299982503987, 3630.6369363063745, 3799.8480060797533, 28656.0, 29334.559981600294, 30029.849850750827, 30457.390852183053, 30716.846415768003, 3934.272159650474, 3983.342748446503, 4025.376066709665, 4045.898852528681, 4087.0, 275779.0, 275817.0, 276351.0, 276774.6161269201, 276782.0, 60980.39019609836, 61334.69332653308, 61489.69255153696, 61520.0, 61572.69213653903, 64544.67727661425, 64699.35300646933, 64807.351926481075, 64815.35184648093, 64849.67575162094, 15167.696646067017, 15397.153156576496, 15522.456714014956, 15551.300191491184, 15555.688886222211, 11713.941430292964, 11730.296182229093, 11730.76538469243, 11735.941320293345, 11737.823932641017, 19674.50813729668, 19976.10107545164, 20117.68058270369, 20140.89929550343, 20148.697769533468, 7407.185209626937, 7520.9623951880985, 7680.654370553339, 7708.075030996316, 7734.7679569613, 933.8700172790864, 1027.7225149209671, 1056.754580429657, 1065.3927261461047, 1080.9135269178446, 28093.0, 28266.010689625764, 28612.570811437847, 28686.856565717037, 28920.276993075342, 950.092661508258, 962.2638681408728, 976.7655762616921, 1034.896510348959, 1044.3264094658903, 12420.937895310466, 13750.449982000608, 14206.289685515683, 14392.0, 14466.20435876037, 512105.0, 518820.0, 521273.0, 521753.0, 675168.0, 52864.0, 53277.200841987404, 53302.73348633232, 53366.46633533615, 53461.465385346426, 1261.9684507887375, 1265.1966001589058, 1331.0948554982704, 1333.0735139078247, 1360.129517109051, 29008.419831602827, 30879.845600771852, 30980.380392392475, 33366.49950250797, 33576.832115839265, 42405.363919540614, 49286.26070609016, 49849.0, 49945.25082123699, 49953.50046499488, 279782.0, 304301.0, 305843.0, 306872.0, 309463.0, 38771.224575508895, 39137.608623913395, 39731.80134099311, 39754.40368394534, 39833.0, 42317.576824231364, 42563.1487370257, 43231.567684324014, 43517.564824352616, 47181.0, 38680.22639547137, 38828.41757373698, 39355.6064439352, 39696.60303396929, 40318.59681403149, 33874.49188262227, 38131.237375252895, 38736.6126338733, 39388.803055984536, 40774.59225407708, 34539.13652158716, 34709.47935780915, 38420.0, 39640.80179599083, 39667.801660991514, 29601.5559766608, 30931.690683092882, 31974.840125799223, 33017.50473742848, 33917.321653567284, 24545.631815522425, 25360.619590706523, 25548.361290967874, 26099.869500652374, 26197.0], "unit": "score", "name": "ext.html", "value": 18969.794925213082}, {"lowerIsBetter": false, "replicates": [350.30639334118445, 351.19751368123843, 353.9274448738009, 354.37276021442034, 354.88466248469246, 14016.088954217968, 14370.928145359285, 16308.266128024237, 16643.41748038819, 17389.47831565052, 15774.684506309866, 16165.757513637276, 16756.329746810112, 16808.075555844425, 16809.256696771787, 5303.363596368441, 5456.48163424476, 5460.699661518614, 5462.508374246317, 5464.316960379952, 3989.2221016901717, 4095.4675892133982, 4099.364598487239, 4100.671946244308, 5401.0, 5798.420157984189, 5936.3173235077875, 5957.404259574051, 5965.582409231356, 5969.462748352647, 5705.087186050233, 5840.269966254218, 5843.240378750777, 5845.386234445365, 5846.678432686222, 5095.872603184913, 5116.565091967187, 5123.385193776733, 5125.384953805567, 5138.306328645623, 12064.577739779066, 12416.255024698547, 19835.50411239716, 20440.080196391198, 20453.5909281815, 2065.6281869263526, 2067.1627990663806, 2087.832973362127, 2186.431527802767, 2313.803326717231, 9449.669261575811, 9577.329586928918, 9622.278329125344, 11729.120315976335, 11838.940805296004, 1763.1536862306166, 1792.6056267621102, 1794.7577077094556, 1837.6692195404821, 1846.7783865936174, 57654.42345576575, 61112.388876111116, 61251.0, 61718.69140654313, 61963.070553941725, 9873.111419972238, 10036.0, 10063.0, 10076.647317343857, 10133.594656213816, 13167.407466664023, 13180.406881690347, 13184.27486488233, 13191.340432978313, 13201.20792752438, 7184.856302874018, 7400.5189662671755, 7401.222871598512, 7434.256574342522, 7473.290037446434, 7232.457565682595, 7238.493305468567, 7272.309130632581, 7304.233055529199, 7327.853442931111, 4155.646770024521, 4215.0305429750715, 4230.259704551691, 4243.3634954757035, 4331.805068771912, 1729.662715770438, 1759.7712297401513, 1787.3833527433014, 1798.5593529585335, 1831.349870795875, 924.630147940829, 931.2038207332769, 933.5425641435647, 951.1582249709057, 1029.912457441126, 14462.566123016326, 15394.15332156742, 16007.519774406786, 16253.51239462818, 16575.0, 901.3600343755876, 935.0479187242871, 940.2008292951074, 941.7221919533754, 989.2728844299434, 9510.524473776284, 9570.61717531291, 9819.165370943407, 9830.74055380368, 9909.405435673883, 522084.0, 526532.0, 538318.0, 539300.0, 543876.0, 80971.0, 82899.75650365249, 83137.16862831415, 84267.5786621063, 86313.0, 1134.6936327191777, 1148.3683973814368, 1149.8620165580185, 1155.4107405223397, 1176.2589568571916, 14630.926845365704, 15406.614834629225, 15655.843441565894, 15740.0, 15762.842371576138, 32696.83651581822, 33110.337793244486, 33265.667343326255, 36260.274794503435, 37019.62980370269, 40723.38914916338, 41490.3403863842, 43035.0, 43181.3522797152, 44869.326960096274, 9239.72280831576, 9320.95339523298, 9446.95276523613, 9510.286728495528, 9521.666741664008, 13116.803247951097, 16926.32294708198, 16993.0, 17276.049817260173, 17679.469615911545, 11705.707357316136, 13904.721905562035, 14048.086874353134, 14144.717105657623, 14310.427582896567, 13090.214587124803, 14294.356753946306, 14368.497102601777, 14383.424663013362, 14680.486182983544, 14314.0, 14316.785248221076, 14781.92609036948, 15126.924365378103, 15309.77035344493, 9562.61749530011, 9580.23358131334, 9751.317407781387, 9755.80488390214, 9776.853347199656, 10400.375977441377, 13354.131981421177, 14165.645858853612, 14436.0, 14598.635034124232], "unit": "score", "name": "jquery.html", "value": 8740.554371701903}, {"lowerIsBetter": false, "replicates": [1298.9350532473375, 1436.6336584171036, 1436.7342041722281, 1556.1596737761602, 1756.1219390304848, 6399.872002559951, 7019.824504387393, 7155.570665760058, 7161.64191790411, 7180.389666878308, 6899.206591241996, 7108.111486064242, 7118.110236220473, 7129.857402851952, 7131.4651401144865, 1918.290232613935, 1961.744973153488, 1962.5289930416668, 2185.344396680993, 2222.03341546427, 2167.8916054197307, 2218.1016688241207, 2221.178164079293, 2223.0552015393473, 2225.354647152324, 2152.0853637204127, 2180.3349978256624, 2226.743924448685, 2228.565429741201, 2229.598672238996, 2171.576542574199, 2178.7821217878163, 2204.1954686539457, 2206.7793220677963, 2231.553689262154, 2201.482651576878, 2213.8118259947923, 2229.9665505017438, 2233.553289342122, 2240.2271216430304, 7109.0, 7134.607596582186, 7153.213146553875, 7179.317964793337, 7196.532225405332, 4369.191699535564, 4395.670324725658, 4415.690901636886, 4458.0, 4459.0858873930765, 2957.7190166934106, 2976.851157442119, 3008.9548656770166, 3024.969750302491, 3073.0, 912.7261821453537, 932.4871320773548, 944.7449188719007, 970.3110791338158, 972.9708108756748, 9616.51917404127, 9645.614175432975, 9661.130498255121, 9662.0, 9669.854952175723, 3921.6470517653547, 3957.3470377387407, 4008.1382502762044, 4014.8394064237687, 4018.578049304781, 8475.406721529434, 8487.0, 8487.278581320657, 8492.74521764348, 8497.065322814486, 4464.553544645574, 4495.1234509271035, 4504.166729155117, 4520.886977825515, 4523.909521809611, 4116.773577453268, 4117.300058989919, 4120.91758164835, 4128.277551428488, 4128.525219599785, 3234.0, 3285.0965984354493, 3291.572095627601, 3500.1249687578106, 3524.559430071241, 1026.8870424253325, 1027.0, 1090.6618948126106, 1105.132471010253, 1106.878243393226, 996.4220751963844, 998.605550807427, 1052.0899421999916, 1079.956801727922, 1233.1306428967557, 6661.034150048313, 6667.733290668416, 6695.46436285096, 6711.664416779142, 6713.765018224339, 1089.0742868561817, 1094.2996482251365, 1098.6923661374828, 1119.6137332620233, 1121.7532142928542, 5346.0, 5415.160650099241, 5426.511613954763, 5435.537979271727, 5439.211314359396, 8188.14024527428, 8269.8346033079, 8324.417290789708, 8385.664573416994, 8427.452215605967, 8310.376721745772, 8313.584320783937, 8316.417850750511, 8317.708880189164, 8320.043195032527, 6731.394174524316, 6831.385175334244, 6873.965630171917, 6876.9999999999, 6947.89578156328, 6772.390484856386, 6827.556208846409, 6834.0, 6838.076859623887, 6839.487038472234, 7602.011738474184, 7642.694292228471, 7800.492967957065, 7876.488028278143, 7887.605619718876, 7514.812129696801, 7819.491733037335, 7823.804404889924, 7827.373810095065, 8044.678212871654, 6318.399752023551, 6323.462505687068, 6349.174607301022, 6390.7763228286785, 6416.679166041773, 6205.875882482415, 6876.449884009367, 6903.482238832007, 6916.757913473004, 6917.13535808024, 6031.849203769765, 6300.842478938063, 6538.476921846336, 6550.6069635822005, 6655.833604159935, 6483.610983341015, 6537.378948999837, 6562.901556476561, 6590.80227593173, 6664.366885145903, 6373.267074286517, 6377.4579160771855, 6381.93618063832, 6542.149520562297, 6584.341565843569, 5896.410358964069, 5941.257342832146, 5946.07835785454, 5946.672932988554, 6016.5487588431915, 6207.441330280297, 6243.125962365363, 6246.718897649525, 6252.062190671436, 6254.4996400286955], "unit": "score", "name": "mootools.html", "value": 4194.087592326475}, {"lowerIsBetter": false, "replicates": [325.0459900192934, 329.2296027296127, 336.0, 336.6616550366882, 337.0159135324852, 6062.605930614507, 6072.8481787955325, 6085.908711369333, 6090.72591733372, 6101.1153382759585, 5927.110933359998, 5957.970210148954, 5976.19321391612, 5992.131140984555, 6021.9698901505435, 4623.815047398117, 4624.144533261349, 4632.791524381394, 4635.235186194274, 4636.744979026153, 4536.818527258905, 4611.33135695324, 4630.536946305359, 4632.583067523922, 4633.073385322932, 4573.268277075668, 4586.312053192031, 4587.587117159455, 4589.059242855224, 4603.8158473661015, 4374.58441448062, 4579.38178345924, 4582.587567118959, 4594.862154135381, 4600.608948239404, 3875.418687196915, 3917.5298964124204, 3930.6612565523756, 3933.0364060805, 3941.605839416064, 5681.7727290908315, 5697.943020569783, 5709.0580054290995, 5727.656340619576, 5742.569307301969, 4986.800527978877, 5076.898462030776, 5144.6913185209005, 5222.477752224785, 5227.503387178212, 6281.528885333618, 6285.497160227171, 6308.526860485482, 6310.2427708674795, 6313.715882785285, 4326.545712700153, 4327.069680018811, 4332.631726303268, 4334.284843000901, 4339.891502712426, 6475.093486911836, 6606.438452731523, 6609.107770450975, 6610.041543976096, 6610.173728283965, 4438.201123797748, 4446.977195245112, 4448.977755111204, 4449.57729015743, 4450.020995381011, 4495.280755079171, 4502.549745025537, 4503.144402563503, 4505.0, 4507.661925355612, 5223.634345595848, 5226.817061402832, 5228.581713462914, 5232.293640358503, 5238.292830467838, 6281.560290779602, 6386.457151142112, 6397.168368112116, 6397.616143031433, 6405.135306733625, 1621.7243068678354, 1641.564985278902, 1642.5975635969025, 1642.8110767261917, 1643.5233782203265, 1109.1016276815806, 1109.2623405435295, 1114.3982249585133, 1130.909527237819, 1134.5631931706187, 6111.052786818051, 6117.632942023492, 6118.265808103056, 6162.661053642003, 6177.598456100339, 6585.275619681831, 6590.176227971504, 6593.967030164818, 6604.438622717027, 6609.867802644017, 5985.670788106609, 6105.175801266861, 6108.389161083856, 6111.388861113853, 6113.908291375633, 3544.2379888324135, 3571.5178450909316, 3573.731970102253, 3576.624454432299, 3579.3557159711504, 6820.386165245052, 6850.3149685032095, 6854.691538880762, 6867.416269617039, 6868.175818901764, 6410.102585638015, 6739.629320387426, 6740.157480314961, 6749.628770417674, 6753.797386078426, 6671.933280667228, 6775.457963362919, 6936.826579335557, 6959.4432445404245, 6972.372486476343, 6569.080328753883, 6624.768133115318, 6639.834004149935, 6647.933520664731, 6657.7669781557415, 6425.421712045938, 6549.901751473636, 6560.573562718408, 6570.882949898624, 6573.474122070318, 6930.168379794457, 6934.0, 6940.757073502403, 6941.652917354011, 6947.444204463732, 4481.395011673382, 4487.932681009853, 4490.348899409632, 4492.685512014127, 4496.0, 6455.48356131499, 6655.933440665725, 6658.966705166443, 6665.800025999228, 6668.433183179484, 6447.194100737408, 6467.838304042437, 6471.611703297817, 6472.935270647234, 6496.252930912817, 6426.068220107964, 6449.903251451138, 6461.547691661539, 6463.192100987377, 6463.256725476443, 6203.193584833943, 6334.524910631629, 6336.510919933719, 6342.778002769881, 6351.174347334817, 6475.838104047437, 6477.77327793525, 6486.481081513562, 6491.318411566717, 6495.188101487314, 6277.30949595535, 6310.242770867341, 6326.0510923360025, 6332.810015699536, 6342.112104305309], "unit": "score", "name": "prototype.html", "value": 4811.099646669633}, {"lowerIsBetter": false, "replicates": [729.8795698709713, 748.3190296829886, 784.333316680821, 804.7164772188357, 830.7134038756628, 12346.62960111197, 12615.495380184804, 12647.55733549326, 12681.809772853403, 12720.109592328541, 12163.391830408465, 12265.448054837532, 13585.388657510435, 13769.518066867662, 13789.241591712476, 801.2228138705447, 816.4692949582759, 816.510093943635, 816.7998840284139, 817.2481317188201, 677.1400321591576, 688.270433340658, 812.1147948735877, 824.2664029014182, 824.9298809601161, 832.5046597274642, 833.8457385383723, 835.778518692547, 841.1252297610478, 842.0611018714151, 697.2260790522516, 714.3856283596103, 826.8222332198576, 828.7348048624442, 829.7427797382801, 616.6084536319424, 620.8106527509108, 625.9061140828867, 627.2848952194502, 627.8399008252912, 11847.881521184763, 11949.581764638197, 11956.0, 11972.940135299355, 11986.820197697041, 11160.386178760245, 12015.158938874283, 12088.33514156721, 12396.81404778929, 12479.50081996719, 9897.257705672031, 9964.750881227956, 10016.599336026551, 10051.396916185053, 10939.234253602252, 3524.3303772283184, 3581.28374325136, 3606.765560238576, 3627.2201476682376, 3649.069487280753, 48069.75965120152, 48146.27780583294, 48781.26828097581, 48955.0, 48997.755011225076, 9674.600678060795, 9714.174295184988, 9724.076212759777, 9732.70801875945, 9734.659286924923, 17810.0, 17834.910825446048, 17850.19674114668, 17863.46409607714, 17902.0, 7352.080989876265, 7443.0, 7635.427342949301, 7668.731594394169, 7737.613119344011, 4206.621404073648, 4298.720583162084, 4327.956720432819, 4414.073044660593, 4437.733735975852, 3073.4928736758184, 3102.612173478315, 3105.829179395155, 3107.2231942014496, 3110.626724792994, 542.5767901037118, 555.7693557173727, 561.6882630140311, 573.6128113523355, 575.088484751665, 486.75175660412737, 504.50054446098096, 546.0035435330537, 603.3544107804607, 607.1499900139839, 7519.360854327334, 7573.0, 7620.3522700569965, 7968.442209045427, 8178.959105204436, 532.8880935003692, 536.3349446686082, 545.3074595263993, 565.172022986327, 575.3326141675636, 3481.669241422061, 3681.1165320323466, 3831.0, 3876.7286289959434, 3899.29812633723, 56906.0, 57028.71485642545, 57229.0, 57231.71384143052, 60846.69576652088, 44768.3284750729, 45392.546074539496, 46469.0, 46569.06861862744, 46825.0, 45080.0, 45416.77291613521, 45754.54245457503, 46417.7679111609, 46926.76536617295, 8185.672573097009, 8356.331493480386, 8420.536870472182, 8426.578671066545, 8694.956525217334, 32056.67943320537, 33500.0, 33720.0, 35839.104022399646, 35865.0, 42558.787206063775, 44410.11179776322, 45005.0, 45709.77145114253, 46939.530604693515, 10109.292349535463, 10151.748317919484, 10260.435676037889, 10365.585376584851, 10483.790324193626, 11550.59572914944, 11553.537858485566, 11588.362640054878, 11797.76404471923, 11841.407929603658, 9723.124918757347, 9967.601295948081, 10020.64927727526, 10029.648962286285, 10064.043915827984, 10698.839517407401, 10717.142628589538, 10911.290766100177, 10974.725631859268, 11188.0, 7507.512011719221, 9867.851982220416, 10114.291999560255, 10475.319104258198, 10624.94738041104, 8888.955555222183, 8998.190162885372, 9128.726138215865, 9363.859542106738, 9751.122398984126, 8760.0, 8764.78088047804, 8869.68956086534, 9196.35625506208, 9603.231741460806], "unit": "score", "name": "yui.html", "value": 6029.366753110475}], "name": "dromaeo_css", "value": 6880.259902670685}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 112.0, 111.0, 110.0, 99.0, 109.0, 109.0, 101.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 146.0, 170.0, 125.0, 155.0, 151.0, 127.0, 169.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 164.0, 162.0, 161.0, 160.0, 160.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 79.0, 96.0, 74.0, 73.0, 71.0, 119.0, 89.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 147.0, 95.0, 97.0, 96.0, 140.0, 94.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 147.0, 145.0, 145.0, 147.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 59.0, 57.0, 58.0, 58.0, 59.0, 68.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 89.0, 86.0, 93.0, 85.0, 85.0, 86.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [124.0, 117.0, 129.0, 115.0, 120.0, 124.0, 120.0, 119.0, 127.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 149.0, 152.0, 150.0, 140.0, 154.0, 152.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 69.0, 69.0, 67.0, 67.0, 66.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1507.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [191.64430816404752], "unit": "score", "name": "DeltaBlue", "value": 345.00372400000015}, {"lowerIsBetter": false, "replicates": [282.326369282891], "unit": "score", "name": "Encrypt", "value": 942.813102}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [809.0614886731391], "unit": "score", "name": "Earley", "value": 823.7482679999999}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [641.025641025641], "unit": "score", "name": "Splay", "value": 127.12596000000005}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 19641.333393404653}]} 00:47:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19641.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1507.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6880.26"}}} 00:47:27 INFO - Return code: 0 00:47:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 00:47:27 INFO - # TBPL SUCCESS # 00:47:27 INFO - Running post-action listener: _resource_record_post_action 00:47:27 INFO - Running post-run listener: _resource_record_post_run 00:47:28 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561852416; Read time: 8; Write time: 667968 00:47:28 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248864768; Read time: 0; Write time: 386556 00:47:29 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308977664; Read time: 8; Write time: 280472 00:47:29 INFO - Running post-run listener: _upload_blobber_files 00:47:29 INFO - Blob upload gear active. 00:47:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 00:47:29 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 00:47:29 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'] 00:47:29 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 00:47:29 INFO - (blobuploader) - INFO - Open directory for files ... 00:47:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 00:47:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:47:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:30 INFO - (blobuploader) - INFO - Done attempting. 00:47:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:47:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:47:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:30 INFO - (blobuploader) - INFO - Done attempting. 00:47:30 INFO - (blobuploader) - INFO - Iteration through files over. 00:47:30 INFO - Return code: 0 00:47:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 00:47:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 00:47:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c843f3ab57949b251db955122181481e0e294055f40ceedae1a0bebc3a7c325b45a8d2389d66d72e874c6fbfcb62f5802c655f77cf9768e88f39fb7cb424a9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771a93e8dc920760ec9ae666ddca090853e8d9ba0985d2f14480f48909943828e45c0af6edbd1ea43cd6cd76418b091cbf74b8f0b79978b14aff5ec8aa5ff134"} 00:47:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 00:47:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 00:47:30 INFO - Contents: 00:47:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c843f3ab57949b251db955122181481e0e294055f40ceedae1a0bebc3a7c325b45a8d2389d66d72e874c6fbfcb62f5802c655f77cf9768e88f39fb7cb424a9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771a93e8dc920760ec9ae666ddca090853e8d9ba0985d2f14480f48909943828e45c0af6edbd1ea43cd6cd76418b091cbf74b8f0b79978b14aff5ec8aa5ff134"} 00:47:30 INFO - Copying logs to upload dir... 00:47:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.867191 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-30 00:47:30.768801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:30.772525) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c843f3ab57949b251db955122181481e0e294055f40ceedae1a0bebc3a7c325b45a8d2389d66d72e874c6fbfcb62f5802c655f77cf9768e88f39fb7cb424a9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771a93e8dc920760ec9ae666ddca090853e8d9ba0985d2f14480f48909943828e45c0af6edbd1ea43cd6cd76418b091cbf74b8f0b79978b14aff5ec8aa5ff134"} build_url:https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c843f3ab57949b251db955122181481e0e294055f40ceedae1a0bebc3a7c325b45a8d2389d66d72e874c6fbfcb62f5802c655f77cf9768e88f39fb7cb424a9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771a93e8dc920760ec9ae666ddca090853e8d9ba0985d2f14480f48909943828e45c0af6edbd1ea43cd6cd76418b091cbf74b8f0b79978b14aff5ec8aa5ff134"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:30.798719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:30.799172) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1451457279.101288-417463442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:30.884491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 00:47:30.884905) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 00:47:30.885294) ========= ========= Total master_lag: 0.28 =========