builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1450800229.73 results: success (0) buildid: 20151222053002 builduid: 0628565107134a4bada3deba2c715cc5 revision: 3cc8559d0d65d5704eedc72238a82c09b4b630cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.734423) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.735202) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.735739) ========= 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=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006377 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.765543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.766243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.791222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.791617) ========= 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=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.845742) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.846476) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.847322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:49.848061) ========= 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=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 08:03:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2015-12-22 08:03:50 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139010 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.020695) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.021015) ========= 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=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.076115 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.130098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.130488) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cc8559d0d65d5704eedc72238a82c09b4b630cd --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 3cc8559d0d65d5704eedc72238a82c09b4b630cd --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=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 08:03:50,403 truncating revision to first 12 chars 2015-12-22 08:03:50,404 Setting DEBUG logging. 2015-12-22 08:03:50,404 attempt 1/10 2015-12-22 08:03:50,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cc8559d0d65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 08:03:50,742 unpacking tar archive at: fx-team-3cc8559d0d65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.732640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.733004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.753245) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.753581) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 08:03:50.754079) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-22 08:03:50.754403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:51 INFO - MultiFileLogger online at 20151222 08:03:51 in /builds/slave/test-pgo 08:03:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:03:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:03:51 INFO - {'append_to_log': False, 08:03:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:03:51 INFO - 'blob_upload_branch': 'Fx-Team', 08:03:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:03:51 INFO - 'branch': 'Fx-Team', 08:03:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:51 INFO - 'config_files': ('talos/linux_config.py',), 08:03:51 INFO - 'default_actions': ('clobber', 08:03:51 INFO - 'read-buildbot-config', 08:03:51 INFO - 'download-and-extract', 08:03:51 INFO - 'populate-webroot', 08:03:51 INFO - 'create-virtualenv', 08:03:51 INFO - 'install', 08:03:51 INFO - 'run-tests'), 08:03:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:51 INFO - 'download_minidump_stackwalk': True, 08:03:51 INFO - 'download_symbols': 'ondemand', 08:03:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:51 INFO - 'installer_path': 'installer.exe', 08:03:51 INFO - 'log_level': 'info', 08:03:51 INFO - 'log_name': 'talos', 08:03:51 INFO - 'log_to_console': True, 08:03:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:51 INFO - 'opt_config_files': (), 08:03:51 INFO - 'pip_index': False, 08:03:51 INFO - 'sps_profile': False, 08:03:51 INFO - 'sps_profile_interval': 0, 08:03:51 INFO - 'suite': 'dromaeojs', 08:03:51 INFO - 'system_bits': '64', 08:03:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:51 INFO - 'title': 'talos-linux64-ix-017', 08:03:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:51 INFO - 'use_talos_json': True, 08:03:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:03:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:51 INFO - 'work_dir': 'build'} 08:03:51 INFO - ##### 08:03:51 INFO - ##### Running clobber step. 08:03:51 INFO - ##### 08:03:51 INFO - Running pre-action listener: _resource_record_pre_action 08:03:51 INFO - Running main action method: clobber 08:03:51 INFO - rmtree: /builds/slave/test-pgo/build 08:03:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:03:52 INFO - Running post-action listener: _resource_record_post_action 08:03:52 INFO - ##### 08:03:52 INFO - ##### Running read-buildbot-config step. 08:03:52 INFO - ##### 08:03:52 INFO - Running pre-action listener: _resource_record_pre_action 08:03:52 INFO - Running main action method: read_buildbot_config 08:03:52 INFO - Using buildbot properties: 08:03:52 INFO - { 08:03:52 INFO - "project": "", 08:03:52 INFO - "product": "firefox", 08:03:52 INFO - "script_repo_revision": "production", 08:03:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:03:52 INFO - "repository": "", 08:03:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:03:52 INFO - "buildid": "20151222053002", 08:03:52 INFO - "pgo_build": "True", 08:03:52 INFO - "basedir": "/builds/slave/test-pgo", 08:03:52 INFO - "buildnumber": 555, 08:03:52 INFO - "slavename": "talos-linux64-ix-017", 08:03:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:03:52 INFO - "platform": "ubuntu64_hw", 08:03:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:03:52 INFO - "branch": "fx-team", 08:03:52 INFO - "repo_path": "integration/fx-team", 08:03:52 INFO - "revision": "3cc8559d0d65d5704eedc72238a82c09b4b630cd", 08:03:52 INFO - "stage_platform": "linux64-pgo", 08:03:52 INFO - "builduid": "0628565107134a4bada3deba2c715cc5", 08:03:52 INFO - "slavebuilddir": "test" 08:03:52 INFO - } 08:03:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:03:52 INFO - Running post-action listener: _resource_record_post_action 08:03:52 INFO - ##### 08:03:52 INFO - ##### Running download-and-extract step. 08:03:52 INFO - ##### 08:03:52 INFO - Running pre-action listener: _resource_record_pre_action 08:03:52 INFO - Running main action method: download_and_extract 08:03:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:52 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:03:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json 08:03:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json 08:03:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:03:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:04:00 INFO - Downloaded 1302 bytes. 08:04:00 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:04:00 INFO - Using the following test package requirements: 08:04:00 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:00 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:00 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'jsshell-linux-x86_64.zip'], 08:04:00 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:00 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:00 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:00 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:00 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:00 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:00 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:00 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:08 INFO - Downloaded 23176552 bytes. 08:04:08 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 08:04:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:08 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 08:04:09 INFO - Return code: 0 08:04:09 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 08:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:09 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:13 INFO - Downloaded 23176552 bytes. 08:04:13 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 08:04:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:13 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 08:04:14 INFO - Return code: 0 08:04:14 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')]} 08:04:14 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:04:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:15 INFO - Downloaded 11132277 bytes. 08:04:15 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 08:04:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:15 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 08:04:15 INFO - Return code: 0 08:04: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')]} 08:04:15 INFO - https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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 08:04:16 INFO - Downloaded 54886189 bytes. 08:04:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:16 INFO - mkdir: /builds/slave/test-pgo/properties 08:04:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:04:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:04:16 INFO - Contents: 08:04:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:16 INFO - Running post-action listener: _resource_record_post_action 08:04:16 INFO - Running post-action listener: set_extra_try_arguments 08:04:16 INFO - ##### 08:04:16 INFO - ##### Running populate-webroot step. 08:04:16 INFO - ##### 08:04:16 INFO - Running pre-action listener: _resource_record_pre_action 08:04:16 INFO - Running main action method: populate_webroot 08:04:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:16 INFO - '--tppagecycles', 08:04:16 INFO - '7'], 08:04:16 INFO - 'tests': ['tsvgm']}}, 08:04:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:04:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'tests': ['damp', 'tps']}, 08:04:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['damp', 'tps']}, 08:04:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:04:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:16 INFO - 'other': {'tests': ['a11yr', 08:04:16 INFO - 'ts_paint', 08:04:16 INFO - 'tpaint', 08:04:16 INFO - 'sessionrestore', 08:04:16 INFO - 'sessionrestore_no_auto_restore']}, 08:04:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['a11yr', 08:04:16 INFO - 'ts_paint', 08:04:16 INFO - 'tpaint', 08:04:16 INFO - 'sessionrestore', 08:04:16 INFO - 'sessionrestore_no_auto_restore']}, 08:04:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['a11yr', 08:04:16 INFO - 'ts_paint', 08:04:16 INFO - 'tpaint', 08:04:16 INFO - 'sessionrestore', 08:04:16 INFO - 'sessionrestore_no_auto_restore']}, 08:04:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['a11yr', 08:04:16 INFO - 'ts_paint', 08:04:16 INFO - 'tpaint', 08:04:16 INFO - 'sessionrestore', 08:04:16 INFO - 'sessionrestore_no_auto_restore']}, 08:04:16 INFO - 'other_l64': {'tests': ['a11yr', 08:04:16 INFO - 'ts_paint', 08:04:16 INFO - 'tpaint', 08:04:16 INFO - 'sessionrestore', 08:04:16 INFO - 'sessionrestore_no_auto_restore']}, 08:04:16 INFO - 'other_nol64': {'tests': ['a11yr', 08:04:16 INFO - 'ts_paint', 08:04:16 INFO - 'tpaint', 08:04:16 INFO - 'sessionrestore', 08:04:16 INFO - 'sessionrestore_no_auto_restore']}, 08:04:16 INFO - 'svgr': {'tests': ['tsvgx', 08:04:16 INFO - 'tsvgr_opacity', 08:04:16 INFO - 'tart', 08:04:16 INFO - 'tscrollx', 08:04:16 INFO - 'cart']}, 08:04:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['tsvgx', 08:04:16 INFO - 'tsvgr_opacity', 08:04:16 INFO - 'tart', 08:04:16 INFO - 'tscrollx', 08:04:16 INFO - 'cart']}, 08:04:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'tests': ['tp5o']}, 08:04:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'talos_options': ['--e10s'], 08:04:16 INFO - 'tests': ['tp5o']}, 08:04:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'talos_options': ['--xperf_path', 08:04:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:16 INFO - 'tests': ['tp5n']}, 08:04:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:16 INFO - 'talos_options': ['--e10s', 08:04:16 INFO - '--xperf_path', 08:04:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:16 INFO - 'tests': ['tp5n']}}, 08:04:16 INFO - 'talos.zip': {'path': '', 08:04:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:16 INFO - Running post-action listener: _resource_record_post_action 08:04:16 INFO - ##### 08:04:16 INFO - ##### Running create-virtualenv step. 08:04:16 INFO - ##### 08:04:16 INFO - Running pre-action listener: _resource_record_pre_action 08:04:16 INFO - Running main action method: create_virtualenv 08:04:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:04:16 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 08:04:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:04:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:16 INFO - Using real prefix '/usr' 08:04:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:04:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:19 INFO - Installing pip.................done. 08:04:19 INFO - Return code: 0 08:04:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:04:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:04:19 INFO - Using env: {'DISPLAY': ':0', 08:04:19 INFO - 'HOME': '/home/cltbld', 08:04:19 INFO - 'LANG': 'en_US.UTF-8', 08:04:19 INFO - 'LANGUAGE': 'en_US:en', 08:04:19 INFO - 'LOGNAME': 'cltbld', 08:04:19 INFO - 'MAIL': '/var/mail/cltbld', 08:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:19 INFO - 'MOZ_NO_REMOTE': '1', 08:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:19 INFO - 'NO_EM_RESTART': '1', 08:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:19 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:19 INFO - 'SHELL': '/bin/bash', 08:04:19 INFO - 'SHLVL': '1', 08:04:19 INFO - 'TERM': 'linux', 08:04:19 INFO - 'TMOUT': '86400', 08:04:19 INFO - 'USER': 'cltbld', 08:04:19 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:19 INFO - '_': '/tools/buildbot/bin/python'} 08:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:19 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 08:04:19 INFO - Cleaning up... 08:04:19 INFO - Return code: 0 08:04:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:04:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:04:19 INFO - Using env: {'DISPLAY': ':0', 08:04:19 INFO - 'HOME': '/home/cltbld', 08:04:19 INFO - 'LANG': 'en_US.UTF-8', 08:04:19 INFO - 'LANGUAGE': 'en_US:en', 08:04:19 INFO - 'LOGNAME': 'cltbld', 08:04:19 INFO - 'MAIL': '/var/mail/cltbld', 08:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:19 INFO - 'MOZ_NO_REMOTE': '1', 08:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:19 INFO - 'NO_EM_RESTART': '1', 08:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:19 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:19 INFO - 'SHELL': '/bin/bash', 08:04:19 INFO - 'SHLVL': '1', 08:04:19 INFO - 'TERM': 'linux', 08:04:19 INFO - 'TMOUT': '86400', 08:04:19 INFO - 'USER': 'cltbld', 08:04:19 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:19 INFO - '_': '/tools/buildbot/bin/python'} 08:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:19 INFO - Downloading/unpacking psutil>=0.7.1 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:21 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:04:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:21 INFO - Installing collected packages: psutil 08:04:21 INFO - Running setup.py install for psutil 08:04:21 INFO - building 'psutil._psutil_linux' extension 08:04:21 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 08:04:21 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 08:04:21 INFO - building 'psutil._psutil_posix' extension 08:04:21 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 08:04:21 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 08:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:22 INFO - Successfully installed psutil 08:04:22 INFO - Cleaning up... 08:04:22 INFO - Return code: 0 08:04:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:22 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 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:22 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 08:04:22 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 08:04:22 INFO - Using env: {'DISPLAY': ':0', 08:04:22 INFO - 'HOME': '/home/cltbld', 08:04:22 INFO - 'LANG': 'en_US.UTF-8', 08:04:22 INFO - 'LANGUAGE': 'en_US:en', 08:04:22 INFO - 'LOGNAME': 'cltbld', 08:04:22 INFO - 'MAIL': '/var/mail/cltbld', 08:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:22 INFO - 'MOZ_NO_REMOTE': '1', 08:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:22 INFO - 'NO_EM_RESTART': '1', 08:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:22 INFO - 'SHELL': '/bin/bash', 08:04:22 INFO - 'SHLVL': '1', 08:04:22 INFO - 'TERM': 'linux', 08:04:22 INFO - 'TMOUT': '86400', 08:04:22 INFO - 'USER': 'cltbld', 08:04:22 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:22 INFO - '_': '/tools/buildbot/bin/python'} 08:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:04:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:04:23 INFO - Installing collected packages: mozsystemmonitor 08:04:23 INFO - Running setup.py install for mozsystemmonitor 08:04:24 INFO - Successfully installed mozsystemmonitor 08:04:24 INFO - Cleaning up... 08:04:24 INFO - Return code: 0 08:04:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:24 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 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:24 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 08:04:24 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 08:04:24 INFO - Using env: {'DISPLAY': ':0', 08:04:24 INFO - 'HOME': '/home/cltbld', 08:04:24 INFO - 'LANG': 'en_US.UTF-8', 08:04:24 INFO - 'LANGUAGE': 'en_US:en', 08:04:24 INFO - 'LOGNAME': 'cltbld', 08:04:24 INFO - 'MAIL': '/var/mail/cltbld', 08:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:24 INFO - 'MOZ_NO_REMOTE': '1', 08:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:24 INFO - 'NO_EM_RESTART': '1', 08:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:24 INFO - 'SHELL': '/bin/bash', 08:04:24 INFO - 'SHLVL': '1', 08:04:24 INFO - 'TERM': 'linux', 08:04:24 INFO - 'TMOUT': '86400', 08:04:24 INFO - 'USER': 'cltbld', 08:04:24 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:24 INFO - '_': '/tools/buildbot/bin/python'} 08:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 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 08:04:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:04:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:04:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:04:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 INFO - Downloading docopt-0.6.1.tar.gz 08:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:04:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:26 INFO - Running setup.py install for blobuploader 08:04:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:04:26 INFO - Running setup.py install for requests 08:04:27 INFO - Running setup.py install for docopt 08:04:27 INFO - Successfully installed blobuploader requests docopt 08:04:27 INFO - Cleaning up... 08:04:27 INFO - Return code: 0 08:04:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:04: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')]} 08:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:27 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 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:27 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 08:04:27 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 08:04:27 INFO - Using env: {'DISPLAY': ':0', 08:04:27 INFO - 'HOME': '/home/cltbld', 08:04:27 INFO - 'LANG': 'en_US.UTF-8', 08:04:27 INFO - 'LANGUAGE': 'en_US:en', 08:04:27 INFO - 'LOGNAME': 'cltbld', 08:04:27 INFO - 'MAIL': '/var/mail/cltbld', 08:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:27 INFO - 'MOZ_NO_REMOTE': '1', 08:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:27 INFO - 'NO_EM_RESTART': '1', 08:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:27 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:27 INFO - 'SHELL': '/bin/bash', 08:04:27 INFO - 'SHLVL': '1', 08:04:27 INFO - 'TERM': 'linux', 08:04:27 INFO - 'TMOUT': '86400', 08:04:27 INFO - 'USER': 'cltbld', 08:04:27 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:27 INFO - '_': '/tools/buildbot/bin/python'} 08:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:27 INFO - Running setup.py (path:/tmp/pip-hAZ6dK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:27 INFO - Running setup.py (path:/tmp/pip-7j_CdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:27 INFO - Running setup.py (path:/tmp/pip-MJIWmB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:27 INFO - Running setup.py (path:/tmp/pip-DUyBcJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:27 INFO - Running setup.py (path:/tmp/pip-VHfoLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:27 INFO - Running setup.py (path:/tmp/pip-7zF7Sc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:27 INFO - Running setup.py (path:/tmp/pip-9uhMCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:28 INFO - Running setup.py (path:/tmp/pip-qHzOv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:28 INFO - Running setup.py (path:/tmp/pip-R1A8uI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:28 INFO - Running setup.py (path:/tmp/pip-z4RzU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:28 INFO - Running setup.py (path:/tmp/pip-xFm_yo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:28 INFO - Running setup.py (path:/tmp/pip-osp3xI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:28 INFO - Running setup.py (path:/tmp/pip-y9xsle-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:28 INFO - Running setup.py (path:/tmp/pip-t4Ie9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:28 INFO - Running setup.py (path:/tmp/pip-DwUJK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:28 INFO - Running setup.py (path:/tmp/pip-ZfuWpN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:28 INFO - Running setup.py (path:/tmp/pip-PmrI3A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:28 INFO - Running setup.py install for manifestparser 08:04:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:04:28 INFO - Running setup.py install for mozcrash 08:04:28 INFO - Running setup.py install for mozdebug 08:04:29 INFO - Running setup.py install for mozdevice 08:04:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Running setup.py install for mozfile 08:04:29 INFO - Running setup.py install for mozhttpd 08:04:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Running setup.py install for mozinfo 08:04:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Running setup.py install for mozInstall 08:04:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Running setup.py install for mozleak 08:04:29 INFO - Running setup.py install for mozlog 08:04:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Running setup.py install for moznetwork 08:04:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:04:29 INFO - Running setup.py install for mozprocess 08:04:30 INFO - Running setup.py install for mozprofile 08:04:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:04:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:04:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:04:30 INFO - Running setup.py install for mozrunner 08:04:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:04:30 INFO - Running setup.py install for mozscreenshot 08:04:30 INFO - Running setup.py install for moztest 08:04:30 INFO - Running setup.py install for mozversion 08:04:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:04:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:30 INFO - Cleaning up... 08:04:30 INFO - Return code: 0 08:04:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:04:30 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')]} 08:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:30 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')]} 08:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:30 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 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:30 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 08:04:30 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 08:04:30 INFO - Using env: {'DISPLAY': ':0', 08:04:30 INFO - 'HOME': '/home/cltbld', 08:04:30 INFO - 'LANG': 'en_US.UTF-8', 08:04:30 INFO - 'LANGUAGE': 'en_US:en', 08:04:30 INFO - 'LOGNAME': 'cltbld', 08:04:30 INFO - 'MAIL': '/var/mail/cltbld', 08:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:30 INFO - 'MOZ_NO_REMOTE': '1', 08:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:30 INFO - 'NO_EM_RESTART': '1', 08:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:30 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:30 INFO - 'SHELL': '/bin/bash', 08:04:30 INFO - 'SHLVL': '1', 08:04:30 INFO - 'TERM': 'linux', 08:04:30 INFO - 'TMOUT': '86400', 08:04:30 INFO - 'USER': 'cltbld', 08:04:30 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:30 INFO - '_': '/tools/buildbot/bin/python'} 08:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:30 INFO - Running setup.py (path:/tmp/pip-dvtKW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:04:30 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)) 08:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:30 INFO - Running setup.py (path:/tmp/pip-qZFa8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:04:30 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)) 08:04:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:30 INFO - Running setup.py (path:/tmp/pip-yx8d1L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:31 INFO - Running setup.py (path:/tmp/pip-r9RGXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:31 INFO - Running setup.py (path:/tmp/pip-I2jrE7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:31 INFO - Running setup.py (path:/tmp/pip-k3zmQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:31 INFO - Running setup.py (path:/tmp/pip-Wlouep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:31 INFO - Running setup.py (path:/tmp/pip-huLlwJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:31 INFO - Running setup.py (path:/tmp/pip-Z3q1ov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:31 INFO - Running setup.py (path:/tmp/pip-5IwS6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:31 INFO - Running setup.py (path:/tmp/pip-B6917U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:31 INFO - Running setup.py (path:/tmp/pip-ZPbSOU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:31 INFO - Running setup.py (path:/tmp/pip-YsLLue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:31 INFO - Running setup.py (path:/tmp/pip-eJRf_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:31 INFO - Running setup.py (path:/tmp/pip-Mewjnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:31 INFO - Running setup.py (path:/tmp/pip-LSH8dt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:04:31 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)) 08:04:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:31 INFO - Running setup.py (path:/tmp/pip-494ItA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 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)) 08:04:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:32 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 08:04:32 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 08:04:32 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 08:04:32 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 08:04:32 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 08:04:32 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 08:04:33 INFO - Downloading blessings-1.5.1.tar.gz 08:04:33 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 08:04:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:33 INFO - Installing collected packages: blessings 08:04:33 INFO - Running setup.py install for blessings 08:04:33 INFO - Successfully installed blessings 08:04:33 INFO - Cleaning up... 08:04:33 INFO - Return code: 0 08:04:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:04:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:04:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:04:34 INFO - Reading from file tmpfile_stdout 08:04:34 INFO - Current package versions: 08:04:34 INFO - argparse == 1.2.1 08:04:34 INFO - blessings == 1.5.1 08:04:34 INFO - blobuploader == 1.2.4 08:04:34 INFO - docopt == 0.6.1 08:04:34 INFO - manifestparser == 1.1 08:04:34 INFO - mozInstall == 1.12 08:04:34 INFO - mozcrash == 0.16 08:04:34 INFO - mozdebug == 0.1 08:04:34 INFO - mozdevice == 0.47 08:04:34 INFO - mozfile == 1.2 08:04:34 INFO - mozhttpd == 0.7 08:04:34 INFO - mozinfo == 0.9 08:04:34 INFO - mozleak == 0.1 08:04:34 INFO - mozlog == 3.1 08:04:34 INFO - moznetwork == 0.27 08:04:34 INFO - mozprocess == 0.22 08:04:34 INFO - mozprofile == 0.28 08:04:34 INFO - mozrunner == 6.11 08:04:34 INFO - mozscreenshot == 0.1 08:04:34 INFO - mozsystemmonitor == 0.0 08:04:34 INFO - moztest == 0.7 08:04:34 INFO - mozversion == 1.4 08:04:34 INFO - psutil == 3.1.1 08:04:34 INFO - requests == 1.2.3 08:04:34 INFO - wsgiref == 0.1.2 08:04:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 08:04:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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 08:04:34 INFO - Using env: {'DISPLAY': ':0', 08:04:34 INFO - 'HOME': '/home/cltbld', 08:04:34 INFO - 'LANG': 'en_US.UTF-8', 08:04:34 INFO - 'LANGUAGE': 'en_US:en', 08:04:34 INFO - 'LOGNAME': 'cltbld', 08:04:34 INFO - 'MAIL': '/var/mail/cltbld', 08:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:34 INFO - 'MOZ_NO_REMOTE': '1', 08:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:34 INFO - 'NO_EM_RESTART': '1', 08:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:34 INFO - 'SHELL': '/bin/bash', 08:04:34 INFO - 'SHLVL': '1', 08:04:34 INFO - 'TERM': 'linux', 08:04:34 INFO - 'TMOUT': '86400', 08:04:34 INFO - 'USER': 'cltbld', 08:04:34 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:34 INFO - '_': '/tools/buildbot/bin/python'} 08:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 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)) 08:04:34 INFO - Cleaning up... 08:04:34 INFO - Return code: 0 08:04:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:04:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:04:34 INFO - Using env: {'DISPLAY': ':0', 08:04:34 INFO - 'HOME': '/home/cltbld', 08:04:34 INFO - 'LANG': 'en_US.UTF-8', 08:04:34 INFO - 'LANGUAGE': 'en_US:en', 08:04:34 INFO - 'LOGNAME': 'cltbld', 08:04:34 INFO - 'MAIL': '/var/mail/cltbld', 08:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:34 INFO - 'MOZ_NO_REMOTE': '1', 08:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:34 INFO - 'NO_EM_RESTART': '1', 08:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:34 INFO - 'SHELL': '/bin/bash', 08:04:34 INFO - 'SHLVL': '1', 08:04:34 INFO - 'TERM': 'linux', 08:04:34 INFO - 'TMOUT': '86400', 08:04:34 INFO - 'USER': 'cltbld', 08:04:34 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:34 INFO - '_': '/tools/buildbot/bin/python'} 08:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:34 INFO - Downloading/unpacking jsonschema 08:04:34 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 08:04:34 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 08:04:34 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 08:04:34 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 08:04:34 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 08:04:34 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 08:04:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:36 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 08:04:36 INFO - Downloading/unpacking functools32 (from jsonschema) 08:04:36 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 08:04:36 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 08:04:36 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 08:04:36 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 08:04:36 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 08:04:36 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 08:04:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:04:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:36 INFO - warning: no files found matching '*.txt' 08:04:36 INFO - no previously-included directories found matching 'build' 08:04:36 INFO - no previously-included directories found matching 'dist' 08:04:36 INFO - no previously-included directories found matching '.git*' 08:04:36 INFO - Installing collected packages: jsonschema, functools32 08:04:36 INFO - Running setup.py install for functools32 08:04:36 INFO - warning: no files found matching '*.txt' 08:04:36 INFO - no previously-included directories found matching 'build' 08:04:36 INFO - no previously-included directories found matching 'dist' 08:04:36 INFO - no previously-included directories found matching '.git*' 08:04:36 INFO - Successfully installed jsonschema functools32 08:04:36 INFO - Cleaning up... 08:04:36 INFO - Return code: 0 08:04:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:04:36 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')]} 08:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:36 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')]} 08:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:36 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 0x7fe9d1db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, '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': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', '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 08:04:36 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 08:04:36 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 08:04:36 INFO - Using env: {'DISPLAY': ':0', 08:04:36 INFO - 'HOME': '/home/cltbld', 08:04:36 INFO - 'LANG': 'en_US.UTF-8', 08:04:36 INFO - 'LANGUAGE': 'en_US:en', 08:04:36 INFO - 'LOGNAME': 'cltbld', 08:04:36 INFO - 'MAIL': '/var/mail/cltbld', 08:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:36 INFO - 'MOZ_NO_REMOTE': '1', 08:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:36 INFO - 'NO_EM_RESTART': '1', 08:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:36 INFO - 'SHELL': '/bin/bash', 08:04:36 INFO - 'SHLVL': '1', 08:04:36 INFO - 'TERM': 'linux', 08:04:36 INFO - 'TMOUT': '86400', 08:04:36 INFO - 'USER': 'cltbld', 08:04:36 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:36 INFO - '_': '/tools/buildbot/bin/python'} 08:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:36 INFO - Downloading/unpacking flake8 08:04:36 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 08:04:36 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 08:04:36 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 08:04:36 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 08:04:36 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 08:04:36 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 08:04:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:04:38 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 08:04:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:04:38 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 08:04:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:38 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 08:04:39 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 08:04:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:39 INFO - no previously-included directories found matching 'docs/_build' 08:04:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:04:39 INFO - Running setup.py install for pep8 08:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:39 INFO - no previously-included directories found matching 'docs/_build' 08:04:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:04:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:04:39 INFO - Cleaning up... 08:04:39 INFO - Return code: 0 08:04:39 INFO - Running post-action listener: _resource_record_post_action 08:04:39 INFO - Running post-action listener: _start_resource_monitoring 08:04:39 INFO - Starting resource monitoring. 08:04:39 INFO - ##### 08:04:39 INFO - ##### Running install step. 08:04:39 INFO - ##### 08:04:39 INFO - Running pre-action listener: _resource_record_pre_action 08:04:39 INFO - Running main action method: install 08:04:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:04:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:04:39 INFO - Reading from file tmpfile_stdout 08:04:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:04:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:04:39 INFO - Reading from file tmpfile_stdout 08:04:39 INFO - Output received: 08:04:39 INFO - Usage: mozinstall [options] installer 08:04:39 INFO - Options: 08:04:39 INFO - -h, --help show this help message and exit 08:04:39 INFO - -d DEST, --destination=DEST 08:04:39 INFO - Directory to install application into. [default: 08:04:39 INFO - "/builds/slave/test-pgo"] 08:04:39 INFO - --app=APP Application being installed. [default: firefox] 08:04:39 INFO - mkdir: /builds/slave/test-pgo/build/application 08:04:39 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'] 08:04:39 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 08:04:55 INFO - Reading from file tmpfile_stdout 08:04:55 INFO - Output received: 08:04:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:04:55 INFO - Running post-action listener: _resource_record_post_action 08:04:55 INFO - ##### 08:04:55 INFO - ##### Running run-tests step. 08:04:55 INFO - ##### 08:04:55 INFO - Running pre-action listener: _resource_record_pre_action 08:04:55 INFO - Running main action method: run_tests 08:04:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:04:55 INFO - Python 2.7.3 08:04:55 INFO - Return code: 0 08:04:55 INFO - grabbing minidump binary from tooltool 08:04:55 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')]} 08:04:55 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 0x2846660>, '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 0x2847560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2847a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:04:55 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 08:04:55 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 08:04:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:55 INFO - Return code: 0 08:04:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:04:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:04:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:04:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:04:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:04:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:04:56 INFO - Return code: 0 08:04:56 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/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 08:04:56 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/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 08:04:56 INFO - Using env: {'DISPLAY': ':0', 08:04:56 INFO - 'HOME': '/home/cltbld', 08:04:56 INFO - 'LANG': 'en_US.UTF-8', 08:04:56 INFO - 'LANGUAGE': 'en_US:en', 08:04:56 INFO - 'LOGNAME': 'cltbld', 08:04:56 INFO - 'MAIL': '/var/mail/cltbld', 08:04:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:04:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:56 INFO - 'MOZ_NO_REMOTE': '1', 08:04:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:56 INFO - 'NO_EM_RESTART': '1', 08:04:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:56 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:04:56 INFO - 'SHELL': '/bin/bash', 08:04:56 INFO - 'SHLVL': '1', 08:04:56 INFO - 'TERM': 'linux', 08:04:56 INFO - 'TMOUT': '86400', 08:04:56 INFO - 'USER': 'cltbld', 08:04:56 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055', 08:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:56 INFO - '_': '/tools/buildbot/bin/python'} 08:04:56 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/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 08:04:56 INFO - mozversion application_buildid: 20151222053002 08:04:56 INFO - mozversion application_changeset: 3cc8559d0d65d5704eedc72238a82c09b4b630cd 08:04:56 INFO - mozversion application_display_name: Nightly 08:04:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:56 INFO - mozversion application_name: Firefox 08:04:56 INFO - mozversion application_remotingname: firefox 08:04:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:04:56 INFO - mozversion application_vendor: Mozilla 08:04:56 INFO - mozversion application_version: 46.0a1 08:04:56 INFO - mozversion platform_buildid: 20151222053002 08:04:56 INFO - mozversion platform_changeset: 3cc8559d0d65d5704eedc72238a82c09b4b630cd 08:04:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:04:56 INFO - mozversion platform_version: 46.0a1 08:04:56 INFO - using testdate: 1450800296 08:04:56 INFO - actual date: 1450800296 08:04:56 INFO - starting webserver on 'localhost:54393' 08:04:56 INFO - SUITE-START | Running 3 tests 08:04:56 INFO - TEST-START | dromaeo_css 08:04:56 INFO - operating with platform_type : linux_ 08:04:56 INFO - Initialising browser for dromaeo_css test... 08:04:56 INFO - TEST-INFO | started process 15182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEGRV4q/profile http://localhost:54393/getInfo.html) 08:05:00 INFO - PROCESS | 15182 | __metrics Screen width/height:1600/1200 08:05:00 INFO - PROCESS | 15182 | colorDepth:24 08:05:00 INFO - PROCESS | 15182 | Browser inner width/height: 1024/697 08:05:00 INFO - PROCESS | 15182 | __metrics 08:05:00 INFO - PROCESS | 15182 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:05:01 INFO - PROCESS | 15182 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:05:01 ERROR - PROCESS | 15182 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:05:01 INFO - TEST-INFO | 15182: exit 0 08:05:01 INFO - Browser initialized. 08:05:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:01 INFO - TEST-INFO | started process 15276 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEGRV4q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:13 INFO - PROCESS | 15276 | RSS: Main: 150155264 08:05:13 INFO - PROCESS | 15276 | 08:06:05 INFO - PROCESS | 15276 | 1450800365100 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] 08:08:13 INFO - PROCESS | 15276 | Cycle 1(1): loaded http://localhost:54393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54393/tests/dromaeo/cssquery-ext.html) 08:08:15 INFO - PROCESS | 15276 | RSS: Main: 277467136 08:08:15 INFO - PROCESS | 15276 | 08:11:17 INFO - PROCESS | 15276 | Cycle 1(1): loaded http://localhost:54393/tests/dromaeo/cssquery-ext.html (next: http://localhost:54393/tests/dromaeo/cssquery-jquery.html) 08:11:18 INFO - PROCESS | 15276 | RSS: Main: 232706048 08:11:18 INFO - PROCESS | 15276 | 08:14:19 INFO - PROCESS | 15276 | Cycle 1(1): loaded http://localhost:54393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54393/tests/dromaeo/cssquery-mootools.html) 08:14:20 INFO - PROCESS | 15276 | RSS: Main: 223195136 08:14:20 INFO - PROCESS | 15276 | 08:17:22 INFO - PROCESS | 15276 | Cycle 1(1): loaded http://localhost:54393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54393/tests/dromaeo/cssquery-prototype.html) 08:17:22 INFO - PROCESS | 15276 | RSS: Main: 209563648 08:17:22 INFO - PROCESS | 15276 | 08:20:25 INFO - PROCESS | 15276 | Cycle 1(1): loaded http://localhost:54393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54393/tests/dromaeo/cssquery-yui.html) 08:20:25 INFO - PROCESS | 15276 | RSS: Main: 215871488 08:20:25 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | Cycle 1(1): loaded http://localhost:54393/tests/dromaeo/cssquery-yui.html (next: http://localhost:54393/tests/dromaeo/cssquery-dojo.html) 08:23:28 INFO - PROCESS | 15276 | RSS: Main: 270188544 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | __start_tp_report 08:23:28 INFO - PROCESS | 15276 | _x_x_mozilla_page_load 08:23:28 INFO - PROCESS | 15276 | _x_x_mozilla_page_load_details 08:23:28 INFO - PROCESS | 15276 | |i|pagename|runs| 08:23:28 INFO - PROCESS | 15276 | |0;dojo.html;3053.328267781088;3119.282565010049;3124.953125703115;3135.576697145886;3166.2875852933093;5109.6678715883445;5222.817201397947;5247.160454327309;5254.133068043778;5255.86860328492;5150.871228219296;5231.843044708665;5308.867278318044;5330.920036199451;5340.25236466895;4825.155597770385;4862;4867.975660121694;4928.26076088586;4954.157793175169;4729.0541891621815;4893.070316639827;4920.458749537548;4933.383327084114;4987.775550100254;4721.173794585934;4764.023375208074;4767.070421267854;4774.928376074362;4791.113643975841;4779.3070004849105;4779.450363208206;4783.043391321749;4814.229723244299;4911.336969509106;4738.407699037621;4776.737279449663;4804.639652026112;4804.783784729696;4853.538913803183;5122.103631864409;5189;5205.843824685266;5229.450907654717;5245.947540524584;5766.423357664242;5772.884542309131;5779.335376431723;5781.450762177628;5785.768569257225;5524.088525393306;5637.746301416446;5641.971790141064;5809.883802323972;5816.185733997244;5217.452167522431;5382.461753824587;5430.212619170237;5434.673919564839;5435.1847222916085;5868.23712917318;5876.941230587725;5878.412158784087;5880.647161170344;5931.4958228550195;5659.236003139606;5670.7731690732735;5681.971590142023;5690.487856092972;5695.088785794336;5427.0773968425465;5623.662580245198;5623.803166889139;5661.46216109469;5804.332501762267;5717.485426311652;5723.170140329629;5723.713814309268;5723.885522289531;5724.971375143181;5685.061964775766;5727.914081288784;5729.856753581111;5734.340550836624;5735.483806457439;4285.228658841438;4351.129774045204;4405.757683327448;4448.065906159743;4487.798049087799;3962.5046869141356;3964.1675248197625;3967.4247234150885;4009.8797036088963;4010.27814993304;5235.267062611238;5437.891242175135;5444.101723215705;5452.454754524516;5457.590680698963;5599.888002239933;5679.801206957819;5681;5788.623739456922;5831.358550559435;5403.162509810985;5409.540189083893;5414.810481633124;5422.593305502024;5426.75579598919;4727.763611819395;4963.677360971526;4967.403911530567;4971.204607262821;5016.272640467112;5780.508656764138;5783.103618939072;5838.795642152504;5874.559408044413;5879.588428809942;5754.251947246831;5768.048272035067;5771.451712087345;5771.451712087345;5774.249347584955;5639.436056394492;5846.590738648254;5866.2960444746905;5868.23712917318;5869.325027621878;5480.123180291134;5520.447955204448;5546.944530554804;5571.470710282517;5608.943910560843;5649.20911072442;5685.829425117253;5694.316681998021;5695.629784064023;5717.8570535736935;5432.320959880015;5532.08720561119;5574.777008919597;5584.86037849057;5586.16207568868;5475.67145971243;5488.533474654699;5548.69482178484;5611.074172761449;5630.183623374506;5626.887462250814;5646.2942132233475;5647.407022262603;5651.4348565143155;5652.349979752381;5450.890982180414;5721.370649228665;5743.368229494836;5762.798302059407;5765.423457654369;5427.864303392446;5434.157705555645;5488.121900496061;5498.862528436821;5500.339959204761 08:23:28 INFO - PROCESS | 15276 | |1;ext.html;572.9680503908323;598.5809933046868;599.8110595162526;605.8031139879539;609.0164384519003;29676.258093547673;35685.82157089214;36346.27307453849;36359;36501.45247821285;41795.16409671805;42472;42541.78729106358;42550.7872460638;42557.57442425575;7308.123025236952;7424.220456852034;8593.226609605133;8833.249173820233;10089.445080520569;10178.236632252574;10255.33340332876;10277.434741089237;10311.48442577868;10314.638987635435;10326.793464130713;10445.895541044569;10448.738781530485;10449.947750261237;10451.947740261288;7526.285002924741;7696.615169241543;10407.479626018745;10665.200109991703;10671.253012289142;10188.337758045704;10306.896931030744;10319.226058045677;10335.948320258425;10340.948295258551;38834.78643417068;39308;39353.60646393557;39354.803225983975;39458.21083578341;3311.420501412243;3311.569495965533;3360.395128876801;3397.0997685613333;3665.4685070664873;29036.27409314763;29474.70525294741;29644.6619712706;29847.552286715498;30623.846880765675;3840.4047372657283;3842.711796615265;3909.7263191576603;3920.4903362562686;3971.8609848655447;265453;266014;266681;266758;267022;55111;55508.72245638746;55555.444445555026;55894.72052639792;55929.720351397984;54782.726086369315;57635;59608.40391596028;60452.09321860175;60803.695981519806;12650.493980240688;12845.22928624267;12879.291638959947;13249.73500529984;13261.602151935458;9690.806183876282;9854.556544955494;10061.79876402468;10154.289199756095;10159.034891685278;19246.615067698847;19465.902670486557;19496.220151194077;19672.70490942637;19723.40829775109;7740.690372385042;7932.881006784903;7962.6416811243635;8026.719064832703;8040.959795200986;876.4434584039053;917.3945196170629;918.2837386838277;931.9207867331353;942.3262367407336;28101.43797124087;28107.57838632422;28706.282342941176;28804.415757133138;29108.563371549444;953.4327075390132;987.782687808681;998.7353351361895;1007.3250921882357;1020.6835880876952;13710.657233569042;13944.51194208198;14894;15310.693786124215;15962.521124366287;298663;301808;302392;302639;302788;51498;51714.74142629338;51809.481905180466;51824.22263666048;51828.74085629548;1135.914806389524;1260.9243445393306;1304.9086563940432;1328.2827273272517;1349.1298112717438;24539.386515336544;27082.32294192661;27308.453830922874;27431.725682742916;27513.862430687717;40253.19493610053;40307.395389069774;40321.59678403178;40376;40379.798101009306;182830;301639;307141;307683;310336;29127;29844;29865.01349864996;29872;29876.253093672833;40398;41455.37816932688;41737;41878.16243675171;42860;35465.468017979234;35483.82258088693;35507.46738798868;35970.8201458991;36624.81687591545;34735.82632086823;35216.471752923215;35285.64714352824;35543.822280889464;35698;34414.65585344215;34774.13064673403;34866;35330.29339413146;35874.10314742152;29729.70270297356;31551;31691;32125.839370802998;32148;24142.75857241405;24171;24188.879055604608;24568;24618.507629846943 08:23:28 INFO - PROCESS | 15276 | |2;jquery.html;346.41801773021314;347.62109300862056;347.81739586716986;359.93521166190084;360.52950899076706;13679.247641379745;14045;16485.50543483696;16780.91609541952;17400.21699023544;16055.438059667915;16283.267252973616;16791.80204948763;17124.74312885308;17149;5265.8946821063655;5400.675959442446;5401.054815407308;5402.864928376803;5403.108487099644;3921.2353591049755;4003.2393845169327;5393.973030134844;5796.971015144918;5953.166556682068;5849.8830023399505;5859.560532960024;5866.765329386841;5886.087656413263;5909.054551271797;5667.4049224831415;5761.135829625548;5770.394108618598;5775.740091695884;5775.884482310373;5030.868054687702;5031.622628302892;5035.144025515671;5047.823326183566;5048.7223202723835;20643.380698579065;21103;21158.259460918795;21168.259110931045;21365.67951480729;2018.7880272571463;2095.109578429177;2190.5728382965326;2207.7461091974305;2486.4405508760565;8782.736517904474;9171.862422063674;9313.487758173365;12646.557370491988;13491.05562610608;1726.240454200148;1745.7555942168106;1813.76421065262;1830.9542261443437;1831.020404083822;56649;58367.12449313264;59438;59897.40102598962;60441.99999999956;9930.702078937644;10109.39343639384;10188.235882308856;10193.337433066827;10232.283740138268;13368.064235503422;13383.933080334731;13407.262600557064;13408.128471649312;13427.19436833793;6893.0005149253075;6922.06552115468;6931.410830079399;6944.756933507303;7090;6379.138816259746;6387.648679322589;6404.103425520431;6430.324815894263;6434.903476447857;4389.4513185851765;4397.912041759147;4426.070525189682;4429.446319210098;4459.643228541774;1703.3612395351743;1766.9558261043576;1772.5923037701143;1796.1468302556182;1837.2467288411688;416.2216654855379;843.6794018273017;873.921347078766;925.3430064654036;995.7908839143716;10261.640842570474;10945.890541094486;11011.119110471143;11143.219974601861;11241.437928103562;429.7722207230173;440.8324836562086;450.93461448089846;461.16529082361035;467.6773026611627;5703;5969.820905372846;5994.310654274727;6063.6664983426335;6094.542909281821;454846;536427;541092;557365;564156;79352;80439.59780201061;82707;84248.57875710705;84545.57727211325;492;497.20199080475317;498.62104800351995;499.3408700515285;499.61280007994094;9444.952775236356;10392.58429662805;10525.631602893862;10686.57253709874;10816.351018938889;35082;35093;35494.46758298576;36258.456123157644;36413.45379819358;47444;48091.519084810105;48137;49491.50508494869;51943.480565193866;9374.812503750023;9709.563069662023;9743.658971935949;9902.653407130716;9982.251331150337;11722.355270459866;11810.291382517076;15219.391224350902;17859.73210401819;18353.3576324828;14246.715065698836;14456.710865782836;14518.419263229775;14821.777673334693;15246.161461119302;14333.211673358066;14687.853121468648;14796.260186990392;14942.925285373503;15006.849931500981;15069.321880515185;15280.388784448942;15281.847181528043;15327.080375177526;15372.538823835303;9883.30816842814;9885.308028437941;9887.752806179615;9972.551235194578;10010.599576016877;9969.192974809757;13868.791968120688;14613.707725845636;14950.551483455514;15225.314860831511 08:23:28 INFO - PROCESS | 15276 | |3;mootools.html;1342.791867260575;1646.8106167790704;1700.2094026277778;1706.2918888661206;1754.2719771294912;6448.322926092763;6955.9652201739045;7153.2489088645725;7153.3204345587155;7159.53463024903;7086.787396378104;7243.746468873591;7272.418206543463;7291.8541629167385;7293.744718934839;1884.1144662008903;1907.437305994735;2168.8373371997086;2190.8137808286274;2226.6214743493565;2237.3959031061604;2241.204372447782;2244.6520789277606;2244.6857439958417;2247.6179049561533;2128.17001369466;2223.7442694090223;2226.543558570489;2227.187076716995;2231.553689262146;2195.012244489978;2214.833887458431;2216.5456081503253;2224.6218142915664;2249.5051088760447;2256.864588124701;2257.345369842744;2280.8745518996448;2291.747907730148;2296.3455415206586;7306.123265208156;7363.742269020612;7366.668499917517;7370.336669699753;7373.5575865448245;4453.131639330332;4517.728936263835;4521.3896124023495;4544.931826022612;4554.544545545452;2887.2926133097526;2925.458790123813;2958.1864987128497;2967.4658561458928;2999.5200767877036;954.2509130332725;957.8563215517659;983.621305797266;985.0789511806483;988.9011098890126;9820.41077535343;9832.754181145458;9834.21326293902;9838.3113182078;9852.261080418926;4081.3265811140827;4107.260693075215;4146.626803587692;4161.063760653889;4164.68764842638;8520.14798520143;8541.914580854113;8600.913990860012;8603.698870539502;8603.741887743377;4543.409356783597;4550.7497087660495;4573.222552166139;4577.908441831145;4578.793954272066;4131.400946862748;4142.047329114321;4176.58234176586;4180.979095104566;4188.874333769992;3210.871565137415;3273.1980664737293;3325.8193341363954;3327.0018994301613;3514.0687717754818;1105.8562386889653;1106.6126855600476;1118.7426891814766;1131.6322195286564;1136.4090672850073;1007.8941711120227;1065.7708592652616;1255.253124390986;1291.728736965229;1292.3473645808995;6888.242293347727;6951.096357473496;6953.687084081229;6960.79117626472;6968.268331825086;1085.918556108295;1107.5680484610848;1114.3258328711174;1115.5537784885948;1130.6947124276398;5518.586106042063;5574.9721251393485;5576.1356989666665;5582.469665381782;5584.134459158756;8267.669293228324;8299.464599049195;8431.156884311642;8440.493570385797;8550.230479256898;8438.873416898752;8457.365697572706;8462.746117616358;8475;8476.49141051539;6336.081268216083;6534.248561415403;6624.436922861611;6640.269570347258;6675.399214070757;6777.45780337562;6931.341522555349;6970;6982.825429364307;6999.51003429755;7441.10706715176;7652.311291983749;7669.271419215165;7771.883421748791;7778.0666320041955;7770.611469426393;7796.142424333206;7829.843403131791;7895.289423951872;7935.761927142195;6739.157605299338;6749.797506074826;6816.2502124767225;6817;6822.590644561342;6175.135481032748;6323.620582765049;6716;6891.965540172267;6970.407515361251;6501.837454063686;6570;6629.966850165718;6751.088603038527;6797.28628494001;6489.286178520453;6531.314212007671;6539.967300163468;6624.370684784938;6643;6609.669516524251;6668.399844014062;6672.065910772399;6673;6687.866242675216;6070.3929607038945;6099.573029887865;6104.38956104386;6112;6112.17485639433;6049.213602231682;6144.508439324933;6190.7214175363115;6196.845078872884;6214.627122372672 08:23:28 INFO - PROCESS | 15276 | |4;prototype.html;333.1089336026129;333.8330834582709;336.70874693390226;341.3786907827754;342.85600047979847;5947.316058653256;5963.522918166547;5974.611650242731;6017.578769486137;6023.668698221596;5860.326062502802;5905.20279762232;5908.172855800191;5913.704314784254;5915.792947246837;4592.931106033412;4594.74728889911;4595.724256544601;4603.10239503297;4616.146012987608;4513.661475389343;4590.013147173357;4605.769711514427;4607.63138948885;4625.098105869357;4528.796204170821;4538.205813982539;4540.704854184484;4550.795214215368;4550.795214215368;4383.605475507188;4481.395011673448;4543.477500087482;4554.886127846814;4560.1335746208115;3954.3475326571083;3956.8615098471705;4007.83968641254;4023.034471726794;4030.1939612077704;5613.270274864282;5621.0444224481935;5621.606487545873;5634.802781902614;5648.576356773258;5036.345275114249;5151.484851514856;5221.425643179247;5278.313819203518;5329.626926115174;6302.369763023661;6309.968450157766;6313.779017734358;6317.715702793339;6332.145160403379;4461.665375096881;4470.26240670289;4471.150481408522;4471.575200355961;4473.105378924196;6420.5184611154355;6467.288598254188;6504.317046710122;6536.084948107269;6542.149520562344;4568.908621827612;4570.108828778356;4572.0627271409285;4572.291294849238;4574.359589657451;4623.583877451046;4624.30635404692;4624.630029597624;4624.884377890512;4628.95371046292;5295.364556253275;5299.841004769786;5308.840734777963;5309.867253318698;5311.097113490716;6192.027701964377;6307.432331090224;6334.809955701337;6350.33321501245;6355.745770169141;1618.902865828054;1637.8198398176191;1638.2709694185974;1640.8769342299374;1641.6470458851165;1096.6709987003867;1121.3328069798456;1121.8261169518737;1128.960486382989;1142.31461123327;6074.635521868702;6081.057436097323;6087.05650624154;6091.939080609226;6100.755969761249;6549.574277671936;6555.8361040973405;6556.442702370352;6559.5408321418;6563.409293163638;5977.372375900555;6075.149479072933;6084.361142080018;6086.360932102154;6086.60437071589;3528.947065794015;3557.6975957043423;3561.6972557332397;3563.2873425315042;3567.518385018041;6663.200415950117;6668.199816022011;6672.065910772496;6672.266050734415;6672.5329226953645;6415.358464153547;6544.509161812883;6644;6670.699818508178;6718.49611279156;6170.259568851767;6516.57642253252;6624.205095388488;6707.865842683119;6712.39588437043;6589.868202636017;6590.7693230736695;6593.505487088391;6598.0102984552705;6604.537682362188;6467.482601391972;6495;6511.218653761579;6515.218173819172;6518.641474718936;6571.5399922005;6707.5304728668525;6710.496712746466;6720.9327906722265;6726.899096513458;4606.700564463299;4607.792649330721;4611.469680986595;4611.815527378867;4614.792334345029;6573.375529324707;6599.53803233769;6602.273749887412;6607.041978912935;6610.405063544112;6271.843203919939;6392.93607063942;6410.743570257324;6432.6462044588;6440.130582371507;6406.967965160145;6414.326495717883;6419.101325814297;6424.229092508929;6427.3251308611925;6300.59046161998;6301.117843502005;6301.275353334425;6301.6219026858535;6319.05214217871;6309.432151106423;6438;6440.323766004502;6441.291457939717;6443.581167224115;6283.37166283368;6284.24589049317;6288.5283603728985;6290;6291.559590828598 08:23:28 INFO - PROCESS | 15276 | |5;yui.html;689.8585789913068;728.3808762551828;784.635144657734;800.459689709446;815.8613035783916;12629.557965471211;13209.537666181686;13213.669658258548;13216.074874758771;13218.471261149554;13624.455021799116;13783.17300961943;13793.310334483262;13811.447542098304;13835.377408016639;687.5840116729381;688.8415664397191;821.3347188777079;823.9629216685233;839.4375768235298;828.4697793412221;829.4649950781742;835.1940377535677;835.3859912963997;835.5947365527715;714.0788382985942;877.1316396767187;884.1158841158841;885.3802338363139;885.4908427654093;701.7333413302938;704.0530486495655;708.3023222126253;708.7944496096126;848.9617967191491;632.9019002054689;635.5709895820303;637.7385272038489;638.4094712391067;639.268038096377;13144.539941102015;13179.67050823737;13245.139065960682;13316;13336.799948000787;10925.726856828564;11135.832962505569;11551.653450396501;11924.821127683004;12347.691307717289;10121.24090693201;10278.794424111476;10355.48222588875;10390.116840068604;10421.27051106423;3656.9817150914073;3657.817109144559;3708.4066549351974;3718.0890681782867;3802.258559580883;47695.523044769805;48172.75913620445;48188;48228.27657585139;48284.27573586434;9257.49083800384;9536.332456728102;9626.843679917614;9687.9031209687;9813.509324533745;14922.626934326729;14958.252087395804;14981.925090374478;14983.175925323994;15005.099694018176;7353.669084891193;7415.925840741632;7535.246475352421;7559.773206803805;7563.773086807405;4267.487901451846;4306.870793876189;4385.144896745104;4408.603225709701;4444.933326000112;2932.545455454408;2976.538636511344;2981.8807247710283;2987.1038688393396;2987.925301867471;557.289455943667;583.3932709981657;596.5436441122545;597.3667912013279;613.349849159892;592.8843875444247;644.5552568727563;680.1600023970393;690.226945820674;696.5089611823652;8383;8461.111583283666;8462.830743385099;8637.222649961408;8758.605862736193;523.7669237189414;550.782440935828;685.5269863793966;691.9317584781538;713.5112447973155;3798.601146879593;3838.1172330363615;3847.6537111659527;3906.121122747416;3912.6087391261217;59273;59489;59601;59653.70173149106;59717;50052.249216261785;50935.23597146046;51319.48680513222;51452.22821657678;51543.74228128835;46569.53430465652;46680.7665961668;46815.5318446818;46937.76531117323;47261.05477890423;7630.656620451982;7650.349720273616;7654.693812247448;7787.961060194662;7848.215178482106;34545.82727086348;34705;34997.300053999286;35495.82252088723;35617.287654246255;41910.37134442925;43262.56737432585;44498.3325250128;45066.549334507545;45917.31124033209;9137.269018478639;9469.147776699854;9516.333856630246;9623.711288661352;9933.900660993297;11576.131790115607;11669.474873630877;11835.82246266324;11890.46492907804;11997.160198786001;10523.94738026305;10593.841092383775;10632.149428045892;10745.462726863469;10918.18113641496;10272.691819245434;10349.793004140025;10451.529681164213;10686.839697404701;10697.090747286567;7114.85770284581;8938.290609397287;10272.435016073889;10389.116925061455;10809.45952702346;9110.863337050083;9261.861072084059;9272.211861991806;9498.19265362452;9650.662226822027;8224.465409748347;8789.134668197881;9144.405613635092;9169.908300916906;9260.814783704154 08:23:28 INFO - PROCESS | 15276 | __end_tp_report 08:23:28 INFO - PROCESS | 15276 | __start_cc_report 08:23:28 INFO - PROCESS | 15276 | _x_x_mozilla_cycle_collect,1019 08:23:28 INFO - PROCESS | 15276 | __end_cc_report 08:23:28 INFO - PROCESS | 15276 | __startTimestamp1450801408603__endTimestamp 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | ------- Summary: start ------- 08:23:28 INFO - PROCESS | 15276 | Number of tests: 6 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | [#0] dojo.html Cycles:165 Average:5298.10 Median:5488.12 stddev:595.66 (10.9%) stddev-sans-first:570.86 08:23:28 INFO - PROCESS | 15276 | Values: 3053.3 3119.3 3125.0 3135.6 3166.3 5109.7 5222.8 5247.2 5254.1 5255.9 5150.9 5231.8 5308.9 5330.9 5340.3 4825.2 4862.0 4868.0 4928.3 4954.2 4729.1 4893.1 4920.5 4933.4 4987.8 4721.2 4764.0 4767.1 4774.9 4791.1 4779.3 4779.5 4783.0 4814.2 4911.3 4738.4 4776.7 4804.6 4804.8 4853.5 5122.1 5189.0 5205.8 5229.5 5245.9 5766.4 5772.9 5779.3 5781.5 5785.8 5524.1 5637.7 5642.0 5809.9 5816.2 5217.5 5382.5 5430.2 5434.7 5435.2 5868.2 5876.9 5878.4 5880.6 5931.5 5659.2 5670.8 5682.0 5690.5 5695.1 5427.1 5623.7 5623.8 5661.5 5804.3 5717.5 5723.2 5723.7 5723.9 5725.0 5685.1 5727.9 5729.9 5734.3 5735.5 4285.2 4351.1 4405.8 4448.1 4487.8 3962.5 3964.2 3967.4 4009.9 4010.3 5235.3 5437.9 5444.1 5452.5 5457.6 5599.9 5679.8 5681.0 5788.6 5831.4 5403.2 5409.5 5414.8 5422.6 5426.8 4727.8 4963.7 4967.4 4971.2 5016.3 5780.5 5783.1 5838.8 5874.6 5879.6 5754.3 5768.0 5771.5 5771.5 5774.2 5639.4 5846.6 5866.3 5868.2 5869.3 5480.1 5520.4 5546.9 5571.5 5608.9 5649.2 5685.8 5694.3 5695.6 5717.9 5432.3 5532.1 5574.8 5584.9 5586.2 5475.7 5488.5 5548.7 5611.1 5630.2 5626.9 5646.3 5647.4 5651.4 5652.3 5450.9 5721.4 5743.4 5762.8 5765.4 5427.9 5434.2 5488.1 5498.9 5500.3 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | [#1] ext.html Cycles:180 Average:44898.68 Median:3311.49 stddev:74474.06 (2249.0%) stddev-sans-first:74608.61 08:23:28 INFO - PROCESS | 15276 | Values: 573.0 598.6 599.8 605.8 609.0 29676.3 35685.8 36346.3 36359.0 36501.5 41795.2 42472.0 42541.8 42550.8 42557.6 7308.1 7424.2 8593.2 8833.2 10089.4 10178.2 10255.3 10277.4 10311.5 10314.6 10326.8 10445.9 10448.7 10449.9 10451.9 7526.3 7696.6 10407.5 10665.2 10671.3 10188.3 10306.9 10319.2 10335.9 10340.9 38834.8 39308.0 39353.6 39354.8 39458.2 3311.4 3311.6 3360.4 3397.1 3665.5 29036.3 29474.7 29644.7 29847.6 30623.8 3840.4 3842.7 3909.7 3920.5 3971.9 265453.0 266014.0 266681.0 266758.0 267022.0 55111.0 55508.7 55555.4 55894.7 55929.7 54782.7 57635.0 59608.4 60452.1 60803.7 12650.5 12845.2 12879.3 13249.7 13261.6 9690.8 9854.6 10061.8 10154.3 10159.0 19246.6 19465.9 19496.2 19672.7 19723.4 7740.7 7932.9 7962.6 8026.7 8041.0 876.4 917.4 918.3 931.9 942.3 28101.4 28107.6 28706.3 28804.4 29108.6 953.4 987.8 998.7 1007.3 1020.7 13710.7 13944.5 14894.0 15310.7 15962.5 298663.0 301808.0 302392.0 302639.0 302788.0 51498.0 51714.7 51809.5 51824.2 51828.7 1135.9 1260.9 1304.9 1328.3 1349.1 24539.4 27082.3 27308.5 27431.7 27513.9 40253.2 40307.4 40321.6 40376.0 40379.8 182830.0 301639.0 307141.0 307683.0 310336.0 29127.0 29844.0 29865.0 29872.0 29876.3 40398.0 41455.4 41737.0 41878.2 42860.0 35465.5 35483.8 35507.5 35970.8 36624.8 34735.8 35216.5 35285.6 35543.8 35698.0 34414.7 34774.1 34866.0 35330.3 35874.1 29729.7 31551.0 31691.0 32125.8 32148.0 24142.8 24171.0 24188.9 24568.0 24618.5 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | [#2] jquery.html Cycles:180 Average:28260.51 Median:2419.37 stddev:87106.25 (3600.4%) stddev-sans-first:87325.39 08:23:28 INFO - PROCESS | 15276 | Values: 346.4 347.6 347.8 359.9 360.5 13679.2 14045.0 16485.5 16780.9 17400.2 16055.4 16283.3 16791.8 17124.7 17149.0 5265.9 5400.7 5401.1 5402.9 5403.1 3921.2 4003.2 5394.0 5797.0 5953.2 5849.9 5859.6 5866.8 5886.1 5909.1 5667.4 5761.1 5770.4 5775.7 5775.9 5030.9 5031.6 5035.1 5047.8 5048.7 20643.4 21103.0 21158.3 21168.3 21365.7 2018.8 2095.1 2190.6 2207.7 2486.4 8782.7 9171.9 9313.5 12646.6 13491.1 1726.2 1745.8 1813.8 1831.0 1831.0 56649.0 58367.1 59438.0 59897.4 60442.0 9930.7 10109.4 10188.2 10193.3 10232.3 13368.1 13383.9 13407.3 13408.1 13427.2 6893.0 6922.1 6931.4 6944.8 7090.0 6379.1 6387.6 6404.1 6430.3 6434.9 4389.5 4397.9 4426.1 4429.4 4459.6 1703.4 1767.0 1772.6 1796.1 1837.2 416.2 843.7 873.9 925.3 995.8 10261.6 10945.9 11011.1 11143.2 11241.4 429.8 440.8 450.9 461.2 467.7 5703.0 5969.8 5994.3 6063.7 6094.5 454846.0 536427.0 541092.0 557365.0 564156.0 79352.0 80439.6 82707.0 84248.6 84545.6 492.0 497.2 498.6 499.3 499.6 9445.0 10392.6 10525.6 10686.6 10816.4 35082.0 35093.0 35494.5 36258.5 36413.5 47444.0 48091.5 48137.0 49491.5 51943.5 9374.8 9709.6 9743.7 9902.7 9982.3 11722.4 11810.3 15219.4 17859.7 18353.4 14246.7 14456.7 14518.4 14821.8 15246.2 14333.2 14687.9 14796.3 14942.9 15006.8 15069.3 15280.4 15281.8 15327.1 15372.5 9883.3 9885.3 9887.8 9972.6 10010.6 9969.2 13868.8 14613.7 14950.6 15225.3 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | [#3] mootools.html Cycles:180 Average:5127.50 Median:6269.12 stddev:2567.20 (40.9%) stddev-sans-first:2558.64 08:23:28 INFO - PROCESS | 15276 | Values: 1342.8 1646.8 1700.2 1706.3 1754.3 6448.3 6956.0 7153.2 7153.3 7159.5 7086.8 7243.7 7272.4 7291.9 7293.7 1884.1 1907.4 2168.8 2190.8 2226.6 2237.4 2241.2 2244.7 2244.7 2247.6 2128.2 2223.7 2226.5 2227.2 2231.6 2195.0 2214.8 2216.5 2224.6 2249.5 2256.9 2257.3 2280.9 2291.7 2296.3 7306.1 7363.7 7366.7 7370.3 7373.6 4453.1 4517.7 4521.4 4544.9 4554.5 2887.3 2925.5 2958.2 2967.5 2999.5 954.3 957.9 983.6 985.1 988.9 9820.4 9832.8 9834.2 9838.3 9852.3 4081.3 4107.3 4146.6 4161.1 4164.7 8520.1 8541.9 8600.9 8603.7 8603.7 4543.4 4550.7 4573.2 4577.9 4578.8 4131.4 4142.0 4176.6 4181.0 4188.9 3210.9 3273.2 3325.8 3327.0 3514.1 1105.9 1106.6 1118.7 1131.6 1136.4 1007.9 1065.8 1255.3 1291.7 1292.3 6888.2 6951.1 6953.7 6960.8 6968.3 1085.9 1107.6 1114.3 1115.6 1130.7 5518.6 5575.0 5576.1 5582.5 5584.1 8267.7 8299.5 8431.2 8440.5 8550.2 8438.9 8457.4 8462.7 8475.0 8476.5 6336.1 6534.2 6624.4 6640.3 6675.4 6777.5 6931.3 6970.0 6982.8 6999.5 7441.1 7652.3 7669.3 7771.9 7778.1 7770.6 7796.1 7829.8 7895.3 7935.8 6739.2 6749.8 6816.3 6817.0 6822.6 6175.1 6323.6 6716.0 6892.0 6970.4 6501.8 6570.0 6630.0 6751.1 6797.3 6489.3 6531.3 6540.0 6624.4 6643.0 6609.7 6668.4 6672.1 6673.0 6687.9 6070.4 6099.6 6104.4 6112.0 6112.2 6049.2 6144.5 6190.7 6196.8 6214.6 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | [#4] prototype.html Cycles:180 Average:5306.00 Median:6049.15 stddev:1580.35 (26.1%) stddev-sans-first:1540.07 08:23:28 INFO - PROCESS | 15276 | Values: 333.1 333.8 336.7 341.4 342.9 5947.3 5963.5 5974.6 6017.6 6023.7 5860.3 5905.2 5908.2 5913.7 5915.8 4592.9 4594.7 4595.7 4603.1 4616.1 4513.7 4590.0 4605.8 4607.6 4625.1 4528.8 4538.2 4540.7 4550.8 4550.8 4383.6 4481.4 4543.5 4554.9 4560.1 3954.3 3956.9 4007.8 4023.0 4030.2 5613.3 5621.0 5621.6 5634.8 5648.6 5036.3 5151.5 5221.4 5278.3 5329.6 6302.4 6310.0 6313.8 6317.7 6332.1 4461.7 4470.3 4471.2 4471.6 4473.1 6420.5 6467.3 6504.3 6536.1 6542.1 4568.9 4570.1 4572.1 4572.3 4574.4 4623.6 4624.3 4624.6 4624.9 4629.0 5295.4 5299.8 5308.8 5309.9 5311.1 6192.0 6307.4 6334.8 6350.3 6355.7 1618.9 1637.8 1638.3 1640.9 1641.6 1096.7 1121.3 1121.8 1129.0 1142.3 6074.6 6081.1 6087.1 6091.9 6100.8 6549.6 6555.8 6556.4 6559.5 6563.4 5977.4 6075.1 6084.4 6086.4 6086.6 3528.9 3557.7 3561.7 3563.3 3567.5 6663.2 6668.2 6672.1 6672.3 6672.5 6415.4 6544.5 6644.0 6670.7 6718.5 6170.3 6516.6 6624.2 6707.9 6712.4 6589.9 6590.8 6593.5 6598.0 6604.5 6467.5 6495.0 6511.2 6515.2 6518.6 6571.5 6707.5 6710.5 6720.9 6726.9 4606.7 4607.8 4611.5 4611.8 4614.8 6573.4 6599.5 6602.3 6607.0 6610.4 6271.8 6392.9 6410.7 6432.6 6440.1 6407.0 6414.3 6419.1 6424.2 6427.3 6300.6 6301.1 6301.3 6301.6 6319.1 6309.4 6438.0 6440.3 6441.3 6443.6 6283.4 6284.2 6288.5 6290.0 6291.6 08:23:28 INFO - PROCESS | 15276 | 08:23:28 INFO - PROCESS | 15276 | [#5] yui.html Cycles:180 Average:13520.50 Median:51385.86 stddev:16134.31 (31.4%) stddev-sans-first:16150.80 08:23:28 INFO - PROCESS | 15276 | Values: 689.9 728.4 784.6 800.5 815.9 12629.6 13209.5 13213.7 13216.1 13218.5 13624.5 13783.2 13793.3 13811.4 13835.4 687.6 688.8 821.3 824.0 839.4 828.5 829.5 835.2 835.4 835.6 714.1 877.1 884.1 885.4 885.5 701.7 704.1 708.3 708.8 849.0 632.9 635.6 637.7 638.4 639.3 13144.5 13179.7 13245.1 13316.0 13336.8 10925.7 11135.8 11551.7 11924.8 12347.7 10121.2 10278.8 10355.5 10390.1 10421.3 3657.0 3657.8 3708.4 3718.1 3802.3 47695.5 48172.8 48188.0 48228.3 48284.3 9257.5 9536.3 9626.8 9687.9 9813.5 14922.6 14958.3 14981.9 14983.2 15005.1 7353.7 7415.9 7535.2 7559.8 7563.8 4267.5 4306.9 4385.1 4408.6 4444.9 2932.5 2976.5 2981.9 2987.1 2987.9 557.3 583.4 596.5 597.4 613.3 592.9 644.6 680.2 690.2 696.5 8383.0 8461.1 8462.8 8637.2 8758.6 523.8 550.8 685.5 691.9 713.5 3798.6 3838.1 3847.7 3906.1 3912.6 59273.0 59489.0 59601.0 59653.7 59717.0 50052.2 50935.2 51319.5 51452.2 51543.7 46569.5 46680.8 46815.5 46937.8 47261.1 7630.7 7650.3 7654.7 7788.0 7848.2 34545.8 34705.0 34997.3 35495.8 35617.3 41910.4 43262.6 44498.3 45066.5 45917.3 9137.3 9469.1 9516.3 9623.7 9933.9 11576.1 11669.5 11835.8 11890.5 11997.2 10523.9 10593.8 10632.1 10745.5 10918.2 10272.7 10349.8 10451.5 10686.8 10697.1 7114.9 8938.3 10272.4 10389.1 10809.5 9110.9 9261.9 9272.2 9498.2 9650.7 8224.5 8789.1 9144.4 9169.9 9260.8 08:23:28 INFO - PROCESS | 15276 | -------- Summary: end -------- 08:23:28 INFO - PROCESS | 15276 | 08:23:29 INFO - TEST-INFO | 15276: exit 0 08:23:29 INFO - TEST-OK | dromaeo_css | took 1112455ms 08:23:29 INFO - TEST-START | kraken 08:23:29 INFO - operating with platform_type : linux_ 08:23:29 INFO - Initialising browser for kraken test... 08:23:29 INFO - TEST-INFO | started process 15472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8eZ_DU/profile http://localhost:54393/getInfo.html) 08:23:33 INFO - PROCESS | 15472 | __metrics Screen width/height:1600/1200 08:23:33 INFO - PROCESS | 15472 | colorDepth:24 08:23:33 INFO - PROCESS | 15472 | Browser inner width/height: 1024/697 08:23:33 INFO - PROCESS | 15472 | __metrics 08:23:33 INFO - PROCESS | 15472 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:23:33 INFO - PROCESS | 15472 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:33 ERROR - PROCESS | 15472 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:23:34 INFO - TEST-INFO | 15472: exit 0 08:23:34 INFO - Browser initialized. 08:23:34 INFO - Running cycle 1/1 for kraken test... 08:23:34 INFO - TEST-INFO | started process 15561 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8eZ_DU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:46 INFO - PROCESS | 15561 | RSS: Main: 149782528 08:23:46 INFO - PROCESS | 15561 | 08:23:48 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54393/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:49 INFO - PROCESS | 15561 | RSS: Main: 187494400 08:23:49 INFO - PROCESS | 15561 | 08:23:51 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54393/tests/kraken/driver.html?testName=audio-dft) 08:23:52 INFO - PROCESS | 15561 | RSS: Main: 175886336 08:23:52 INFO - PROCESS | 15561 | 08:23:55 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54393/tests/kraken/driver.html?testName=audio-fft) 08:23:55 INFO - PROCESS | 15561 | RSS: Main: 160264192 08:23:55 INFO - PROCESS | 15561 | 08:23:57 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54393/tests/kraken/driver.html?testName=audio-oscillator) 08:23:58 INFO - PROCESS | 15561 | RSS: Main: 163065856 08:23:58 INFO - PROCESS | 15561 | 08:24:00 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:01 INFO - PROCESS | 15561 | RSS: Main: 165298176 08:24:01 INFO - PROCESS | 15561 | 08:24:03 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54393/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:04 INFO - PROCESS | 15561 | RSS: Main: 164528128 08:24:04 INFO - PROCESS | 15561 | 08:24:07 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54393/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:08 INFO - PROCESS | 15561 | RSS: Main: 166871040 08:24:08 INFO - PROCESS | 15561 | 08:24:11 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54393/tests/kraken/driver.html?testName=json-parse-financial) 08:24:11 INFO - PROCESS | 15561 | RSS: Main: 165515264 08:24:11 INFO - PROCESS | 15561 | 08:24:13 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:13 INFO - PROCESS | 15561 | RSS: Main: 177410048 08:24:13 INFO - PROCESS | 15561 | 08:24:15 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:16 INFO - PROCESS | 15561 | RSS: Main: 176873472 08:24:16 INFO - PROCESS | 15561 | 08:24:18 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:18 INFO - PROCESS | 15561 | RSS: Main: 185737216 08:24:18 INFO - PROCESS | 15561 | 08:24:21 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:21 INFO - PROCESS | 15561 | RSS: Main: 193044480 08:24:21 INFO - PROCESS | 15561 | 08:24:24 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:24 INFO - PROCESS | 15561 | RSS: Main: 188911616 08:24:24 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:54393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54393/tests/kraken/driver.html?testName=ai-astar) 08:24:26 INFO - PROCESS | 15561 | RSS: Main: 246886400 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | __start_tp_report 08:24:26 INFO - PROCESS | 15561 | _x_x_mozilla_page_load 08:24:26 INFO - PROCESS | 15561 | _x_x_mozilla_page_load_details 08:24:26 INFO - PROCESS | 15561 | |i|pagename|runs| 08:24:26 INFO - PROCESS | 15561 | |0;ai-astar;110;111;106;109;110;111;99;109;112;117 08:24:26 INFO - PROCESS | 15561 | |1;audio-beat-detection;150;124;147;163;126;154;148;123;157;122 08:24:26 INFO - PROCESS | 15561 | |2;audio-dft;160;160;161;161;162;159;160;165;161;163 08:24:26 INFO - PROCESS | 15561 | |3;audio-fft;72;72;78;88;73;72;71;95;90;73 08:24:26 INFO - PROCESS | 15561 | |4;audio-oscillator;93;94;140;92;93;93;137;94;93;138 08:24:26 INFO - PROCESS | 15561 | |5;imaging-gaussian-blur;109;109;109;110;109;110;109;109;109;110 08:24:26 INFO - PROCESS | 15561 | |6;imaging-darkroom;145;145;145;145;147;147;147;146;144;145 08:24:26 INFO - PROCESS | 15561 | |7;imaging-desaturate;96;95;95;95;96;96;95;95;96;95 08:24:26 INFO - PROCESS | 15561 | |8;json-parse-financial;59;57;57;57;57;58;57;65;62;55 08:24:26 INFO - PROCESS | 15561 | |9;json-stringify-tinderbox;68;69;67;67;67;67;68;68;68;67 08:24:26 INFO - PROCESS | 15561 | |10;stanford-crypto-aes;91;84;86;87;85;85;85;87;93;85 08:24:26 INFO - PROCESS | 15561 | |11;stanford-crypto-ccm;115;118;122;111;119;121;123;123;124;124 08:24:26 INFO - PROCESS | 15561 | |12;stanford-crypto-pbkdf2;141;155;144;149;152;140;148;149;152;141 08:24:26 INFO - PROCESS | 15561 | |13;stanford-crypto-sha256-iterative;66;66;67;66;69;66;65;66;66;65 08:24:26 INFO - PROCESS | 15561 | __end_tp_report 08:24:26 INFO - PROCESS | 15561 | __start_cc_report 08:24:26 INFO - PROCESS | 15561 | _x_x_mozilla_cycle_collect,928 08:24:26 INFO - PROCESS | 15561 | __end_cc_report 08:24:26 INFO - PROCESS | 15561 | __startTimestamp1450801466871__endTimestamp 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | ------- Summary: start ------- 08:24:26 INFO - PROCESS | 15561 | Number of tests: 14 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:4.60 (4.1%) stddev-sans-first:4.87 08:24:26 INFO - PROCESS | 15561 | Values: 110.0 111.0 106.0 109.0 110.0 111.0 99.0 109.0 112.0 117.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:149.00 stddev:15.89 (10.7%) stddev-sans-first:16.55 08:24:26 INFO - PROCESS | 15561 | Values: 150.0 124.0 147.0 163.0 126.0 154.0 148.0 123.0 157.0 122.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.75 (1.1%) stddev-sans-first:1.80 08:24:26 INFO - PROCESS | 15561 | Values: 160.0 160.0 161.0 161.0 162.0 159.0 160.0 165.0 161.0 163.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#3] audio-fft Cycles:10 Average:78.40 Median:75.50 stddev:9.06 (12.0%) stddev-sans-first:9.31 08:24:26 INFO - PROCESS | 15561 | Values: 72.0 72.0 78.0 88.0 73.0 72.0 71.0 95.0 90.0 73.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:21.85 (23.5%) stddev-sans-first:22.60 08:24:26 INFO - PROCESS | 15561 | Values: 93.0 94.0 140.0 92.0 93.0 93.0 137.0 94.0 93.0 138.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:24:26 INFO - PROCESS | 15561 | Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 08:24:26 INFO - PROCESS | 15561 | Values: 145.0 145.0 145.0 145.0 147.0 147.0 147.0 146.0 144.0 145.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:24:26 INFO - PROCESS | 15561 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.50 stddev:2.95 (5.1%) stddev-sans-first:3.12 08:24:26 INFO - PROCESS | 15561 | Values: 59.0 57.0 57.0 57.0 57.0 58.0 57.0 65.0 62.0 55.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 08:24:26 INFO - PROCESS | 15561 | Values: 68.0 69.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:2.94 (3.4%) stddev-sans-first:2.69 08:24:26 INFO - PROCESS | 15561 | Values: 91.0 84.0 86.0 87.0 85.0 85.0 85.0 87.0 93.0 85.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:122.50 stddev:4.29 (3.5%) stddev-sans-first:4.16 08:24:26 INFO - PROCESS | 15561 | Values: 115.0 118.0 122.0 111.0 119.0 121.0 123.0 123.0 124.0 124.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:149.00 stddev:5.30 (3.6%) stddev-sans-first:5.14 08:24:26 INFO - PROCESS | 15561 | Values: 141.0 155.0 144.0 149.0 152.0 140.0 148.0 149.0 152.0 141.0 08:24:26 INFO - PROCESS | 15561 | 08:24:26 INFO - PROCESS | 15561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 08:24:26 INFO - PROCESS | 15561 | Values: 66.0 66.0 67.0 66.0 69.0 66.0 65.0 66.0 66.0 65.0 08:24:26 INFO - PROCESS | 15561 | -------- Summary: end -------- 08:24:26 INFO - PROCESS | 15561 | 08:24:27 INFO - TEST-INFO | 15561: exit 0 08:24:27 INFO - TEST-OK | kraken | took 58443ms 08:24:27 INFO - TEST-START | v8_7 08:24:27 INFO - operating with platform_type : linux_ 08:24:27 INFO - Initialising browser for v8_7 test... 08:24:27 INFO - TEST-INFO | started process 15813 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM_9AcF/profile http://localhost:54393/getInfo.html) 08:24:31 INFO - PROCESS | 15813 | __metrics Screen width/height:1600/1200 08:24:31 INFO - PROCESS | 15813 | colorDepth:24 08:24:31 INFO - PROCESS | 15813 | Browser inner width/height: 1024/697 08:24:31 INFO - PROCESS | 15813 | __metrics 08:24:31 INFO - PROCESS | 15813 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:24:31 INFO - PROCESS | 15813 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:31 ERROR - PROCESS | 15813 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:24:32 INFO - TEST-INFO | 15813: exit 0 08:24:32 INFO - Browser initialized. 08:24:32 INFO - Running cycle 1/1 for v8_7 test... 08:24:32 INFO - TEST-INFO | started process 15899 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM_9AcF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:44 INFO - PROCESS | 15899 | RSS: Main: 150331392 08:24:44 INFO - PROCESS | 15899 | 08:25:05 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:54393/tests/v8_7/run.html (next: http://localhost:54393/tests/v8_7/run.html) 08:25:06 INFO - PROCESS | 15899 | RSS: Main: 620769280 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | __start_tp_report 08:25:06 INFO - PROCESS | 15899 | _x_x_mozilla_page_load 08:25:06 INFO - PROCESS | 15899 | _x_x_mozilla_page_load_details 08:25:06 INFO - PROCESS | 15899 | |i|pagename|runs| 08:25:06 INFO - PROCESS | 15899 | |0;Richards;165.7550140891762 08:25:06 INFO - PROCESS | 15899 | |1;DeltaBlue;189.25056775170324 08:25:06 INFO - PROCESS | 15899 | |2;Encrypt;280.0336040324839 08:25:06 INFO - PROCESS | 15899 | |3;Decrypt;5191.709844559586 08:25:06 INFO - PROCESS | 15899 | |4;RayTrace;1956.9471624266146 08:25:06 INFO - PROCESS | 15899 | |5;Earley;793.0214115781126 08:25:06 INFO - PROCESS | 15899 | |6;Boyer;11988.095238095239 08:25:06 INFO - PROCESS | 15899 | |7;RegExp;26153.846153846152 08:25:06 INFO - PROCESS | 15899 | |8;Splay;639.2009987515605 08:25:06 INFO - PROCESS | 15899 | |9;NavierStokes;4835.748792270531 08:25:06 INFO - PROCESS | 15899 | __end_tp_report 08:25:06 INFO - PROCESS | 15899 | __startTimestamp1450801506120__endTimestamp 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | ------- Summary: start ------- 08:25:06 INFO - PROCESS | 15899 | Number of tests: 10 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#0] Richards Cycles:1 Average:165.76 Median:165.76 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 165.8 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#1] DeltaBlue Cycles:1 Average:189.25 Median:189.25 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 189.3 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 280.0 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 5191.7 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#4] RayTrace Cycles:1 Average:1956.95 Median:1956.95 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 1956.9 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 793.0 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 11988.1 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 26153.8 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#8] Splay Cycles:1 Average:639.20 Median:639.20 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 639.2 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - PROCESS | 15899 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:25:06 INFO - PROCESS | 15899 | Values: 4835.7 08:25:06 INFO - PROCESS | 15899 | -------- Summary: end -------- 08:25:06 INFO - PROCESS | 15899 | 08:25:06 INFO - TEST-INFO | 15899: exit 0 08:25:06 INFO - TEST-OK | v8_7 | took 39161ms 08:25:06 INFO - SUITE-END | took 1210s 08:25:07 INFO - Completed test suite (00:20:10) 08:25:07 INFO - Working with test: dromaeo_css 08:25:07 INFO - Generating results file: dromaeo_css 08:25:07 INFO - Working with test: kraken 08:25:07 INFO - Generating results file: kraken 08:25:07 INFO - javascript benchmark 08:25:07 INFO - Working with test: v8_7 08:25:07 INFO - Generating results file: v8_7 08:25:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:25:07 INFO - process_Request line: dromaeo_css 6781.50 graph.html#tests=[[72,64,35]] 08:25:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:07 INFO - process_Request line: kraken 1493.50 graph.html#tests=[[232,64,35]] 08:25:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:07 INFO - process_Request line: v8_7 19759.38 graph.html#tests=[[230,64,35]] 08:25:07 INFO - RETURN: dromaeo_css: 6781.50 08:25:07 INFO - RETURN: kraken: 1493.50 08:25:07 INFO - RETURN: v8_7: 19759.38 08:25:07 INFO - javascript benchmark 08:25:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3053.328267781088, 3119.282565010049, 3124.953125703115, 3135.576697145886, 3166.2875852933093, 5109.6678715883445, 5222.817201397947, 5247.160454327309, 5254.133068043778, 5255.86860328492, 5150.871228219296, 5231.843044708665, 5308.867278318044, 5330.920036199451, 5340.25236466895, 4825.155597770385, 4862.0, 4867.975660121694, 4928.26076088586, 4954.157793175169, 4729.0541891621815, 4893.070316639827, 4920.458749537548, 4933.383327084114, 4987.775550100254, 4721.173794585934, 4764.023375208074, 4767.070421267854, 4774.928376074362, 4791.113643975841, 4779.3070004849105, 4779.450363208206, 4783.043391321749, 4814.229723244299, 4911.336969509106, 4738.407699037621, 4776.737279449663, 4804.639652026112, 4804.783784729696, 4853.538913803183, 5122.103631864409, 5189.0, 5205.843824685266, 5229.450907654717, 5245.947540524584, 5766.423357664242, 5772.884542309131, 5779.335376431723, 5781.450762177628, 5785.768569257225, 5524.088525393306, 5637.746301416446, 5641.971790141064, 5809.883802323972, 5816.185733997244, 5217.452167522431, 5382.461753824587, 5430.212619170237, 5434.673919564839, 5435.1847222916085, 5868.23712917318, 5876.941230587725, 5878.412158784087, 5880.647161170344, 5931.4958228550195, 5659.236003139606, 5670.7731690732735, 5681.971590142023, 5690.487856092972, 5695.088785794336, 5427.0773968425465, 5623.662580245198, 5623.803166889139, 5661.46216109469, 5804.332501762267, 5717.485426311652, 5723.170140329629, 5723.713814309268, 5723.885522289531, 5724.971375143181, 5685.061964775766, 5727.914081288784, 5729.856753581111, 5734.340550836624, 5735.483806457439, 4285.228658841438, 4351.129774045204, 4405.757683327448, 4448.065906159743, 4487.798049087799, 3962.5046869141356, 3964.1675248197625, 3967.4247234150885, 4009.8797036088963, 4010.27814993304, 5235.267062611238, 5437.891242175135, 5444.101723215705, 5452.454754524516, 5457.590680698963, 5599.888002239933, 5679.801206957819, 5681.0, 5788.623739456922, 5831.358550559435, 5403.162509810985, 5409.540189083893, 5414.810481633124, 5422.593305502024, 5426.75579598919, 4727.763611819395, 4963.677360971526, 4967.403911530567, 4971.204607262821, 5016.272640467112, 5780.508656764138, 5783.103618939072, 5838.795642152504, 5874.559408044413, 5879.588428809942, 5754.251947246831, 5768.048272035067, 5771.451712087345, 5771.451712087345, 5774.249347584955, 5639.436056394492, 5846.590738648254, 5866.2960444746905, 5868.23712917318, 5869.325027621878, 5480.123180291134, 5520.447955204448, 5546.944530554804, 5571.470710282517, 5608.943910560843, 5649.20911072442, 5685.829425117253, 5694.316681998021, 5695.629784064023, 5717.8570535736935, 5432.320959880015, 5532.08720561119, 5574.777008919597, 5584.86037849057, 5586.16207568868, 5475.67145971243, 5488.533474654699, 5548.69482178484, 5611.074172761449, 5630.183623374506, 5626.887462250814, 5646.2942132233475, 5647.407022262603, 5651.4348565143155, 5652.349979752381, 5450.890982180414, 5721.370649228665, 5743.368229494836, 5762.798302059407, 5765.423457654369, 5427.864303392446, 5434.157705555645, 5488.121900496061, 5498.862528436821, 5500.339959204761], "unit": "score", "name": "dojo.html", "value": 5258.7950348604545}, {"lowerIsBetter": false, "replicates": [572.9680503908323, 598.5809933046868, 599.8110595162526, 605.8031139879539, 609.0164384519003, 29676.258093547673, 35685.82157089214, 36346.27307453849, 36359.0, 36501.45247821285, 41795.16409671805, 42472.0, 42541.78729106358, 42550.7872460638, 42557.57442425575, 7308.123025236952, 7424.220456852034, 8593.226609605133, 8833.249173820233, 10089.445080520569, 10178.236632252574, 10255.33340332876, 10277.434741089237, 10311.48442577868, 10314.638987635435, 10326.793464130713, 10445.895541044569, 10448.738781530485, 10449.947750261237, 10451.947740261288, 7526.285002924741, 7696.615169241543, 10407.479626018745, 10665.200109991703, 10671.253012289142, 10188.337758045704, 10306.896931030744, 10319.226058045677, 10335.948320258425, 10340.948295258551, 38834.78643417068, 39308.0, 39353.60646393557, 39354.803225983975, 39458.21083578341, 3311.420501412243, 3311.569495965533, 3360.395128876801, 3397.0997685613333, 3665.4685070664873, 29036.27409314763, 29474.70525294741, 29644.6619712706, 29847.552286715498, 30623.846880765675, 3840.4047372657283, 3842.711796615265, 3909.7263191576603, 3920.4903362562686, 3971.8609848655447, 265453.0, 266014.0, 266681.0, 266758.0, 267022.0, 55111.0, 55508.72245638746, 55555.444445555026, 55894.72052639792, 55929.720351397984, 54782.726086369315, 57635.0, 59608.40391596028, 60452.09321860175, 60803.695981519806, 12650.493980240688, 12845.22928624267, 12879.291638959947, 13249.73500529984, 13261.602151935458, 9690.806183876282, 9854.556544955494, 10061.79876402468, 10154.289199756095, 10159.034891685278, 19246.615067698847, 19465.902670486557, 19496.220151194077, 19672.70490942637, 19723.40829775109, 7740.690372385042, 7932.881006784903, 7962.6416811243635, 8026.719064832703, 8040.959795200986, 876.4434584039053, 917.3945196170629, 918.2837386838277, 931.9207867331353, 942.3262367407336, 28101.43797124087, 28107.57838632422, 28706.282342941176, 28804.415757133138, 29108.563371549444, 953.4327075390132, 987.782687808681, 998.7353351361895, 1007.3250921882357, 1020.6835880876952, 13710.657233569042, 13944.51194208198, 14894.0, 15310.693786124215, 15962.521124366287, 298663.0, 301808.0, 302392.0, 302639.0, 302788.0, 51498.0, 51714.74142629338, 51809.481905180466, 51824.22263666048, 51828.74085629548, 1135.914806389524, 1260.9243445393306, 1304.9086563940432, 1328.2827273272517, 1349.1298112717438, 24539.386515336544, 27082.32294192661, 27308.453830922874, 27431.725682742916, 27513.862430687717, 40253.19493610053, 40307.395389069774, 40321.59678403178, 40376.0, 40379.798101009306, 182830.0, 301639.0, 307141.0, 307683.0, 310336.0, 29127.0, 29844.0, 29865.01349864996, 29872.0, 29876.253093672833, 40398.0, 41455.37816932688, 41737.0, 41878.16243675171, 42860.0, 35465.468017979234, 35483.82258088693, 35507.46738798868, 35970.8201458991, 36624.81687591545, 34735.82632086823, 35216.471752923215, 35285.64714352824, 35543.822280889464, 35698.0, 34414.65585344215, 34774.13064673403, 34866.0, 35330.29339413146, 35874.10314742152, 29729.70270297356, 31551.0, 31691.0, 32125.839370802998, 32148.0, 24142.75857241405, 24171.0, 24188.879055604608, 24568.0, 24618.507629846943], "unit": "score", "name": "ext.html", "value": 18142.33121084793}, {"lowerIsBetter": false, "replicates": [346.41801773021314, 347.62109300862056, 347.81739586716986, 359.93521166190084, 360.52950899076706, 13679.247641379745, 14045.0, 16485.50543483696, 16780.91609541952, 17400.21699023544, 16055.438059667915, 16283.267252973616, 16791.80204948763, 17124.74312885308, 17149.0, 5265.8946821063655, 5400.675959442446, 5401.054815407308, 5402.864928376803, 5403.108487099644, 3921.2353591049755, 4003.2393845169327, 5393.973030134844, 5796.971015144918, 5953.166556682068, 5849.8830023399505, 5859.560532960024, 5866.765329386841, 5886.087656413263, 5909.054551271797, 5667.4049224831415, 5761.135829625548, 5770.394108618598, 5775.740091695884, 5775.884482310373, 5030.868054687702, 5031.622628302892, 5035.144025515671, 5047.823326183566, 5048.7223202723835, 20643.380698579065, 21103.0, 21158.259460918795, 21168.259110931045, 21365.67951480729, 2018.7880272571463, 2095.109578429177, 2190.5728382965326, 2207.7461091974305, 2486.4405508760565, 8782.736517904474, 9171.862422063674, 9313.487758173365, 12646.557370491988, 13491.05562610608, 1726.240454200148, 1745.7555942168106, 1813.76421065262, 1830.9542261443437, 1831.020404083822, 56649.0, 58367.12449313264, 59438.0, 59897.40102598962, 60441.99999999956, 9930.702078937644, 10109.39343639384, 10188.235882308856, 10193.337433066827, 10232.283740138268, 13368.064235503422, 13383.933080334731, 13407.262600557064, 13408.128471649312, 13427.19436833793, 6893.0005149253075, 6922.06552115468, 6931.410830079399, 6944.756933507303, 7090.0, 6379.138816259746, 6387.648679322589, 6404.103425520431, 6430.324815894263, 6434.903476447857, 4389.4513185851765, 4397.912041759147, 4426.070525189682, 4429.446319210098, 4459.643228541774, 1703.3612395351743, 1766.9558261043576, 1772.5923037701143, 1796.1468302556182, 1837.2467288411688, 416.2216654855379, 843.6794018273017, 873.921347078766, 925.3430064654036, 995.7908839143716, 10261.640842570474, 10945.890541094486, 11011.119110471143, 11143.219974601861, 11241.437928103562, 429.7722207230173, 440.8324836562086, 450.93461448089846, 461.16529082361035, 467.6773026611627, 5703.0, 5969.820905372846, 5994.310654274727, 6063.6664983426335, 6094.542909281821, 454846.0, 536427.0, 541092.0, 557365.0, 564156.0, 79352.0, 80439.59780201061, 82707.0, 84248.57875710705, 84545.57727211325, 492.0, 497.20199080475317, 498.62104800351995, 499.3408700515285, 499.61280007994094, 9444.952775236356, 10392.58429662805, 10525.631602893862, 10686.57253709874, 10816.351018938889, 35082.0, 35093.0, 35494.46758298576, 36258.456123157644, 36413.45379819358, 47444.0, 48091.519084810105, 48137.0, 49491.50508494869, 51943.480565193866, 9374.812503750023, 9709.563069662023, 9743.658971935949, 9902.653407130716, 9982.251331150337, 11722.355270459866, 11810.291382517076, 15219.391224350902, 17859.73210401819, 18353.3576324828, 14246.715065698836, 14456.710865782836, 14518.419263229775, 14821.777673334693, 15246.161461119302, 14333.211673358066, 14687.853121468648, 14796.260186990392, 14942.925285373503, 15006.849931500981, 15069.321880515185, 15280.388784448942, 15281.847181528043, 15327.080375177526, 15372.538823835303, 9883.30816842814, 9885.308028437941, 9887.752806179615, 9972.551235194578, 10010.599576016877, 9969.192974809757, 13868.791968120688, 14613.707725845636, 14950.551483455514, 15225.314860831511], "unit": "score", "name": "jquery.html", "value": 8156.2600195418}, {"lowerIsBetter": false, "replicates": [1342.791867260575, 1646.8106167790704, 1700.2094026277778, 1706.2918888661206, 1754.2719771294912, 6448.322926092763, 6955.9652201739045, 7153.2489088645725, 7153.3204345587155, 7159.53463024903, 7086.787396378104, 7243.746468873591, 7272.418206543463, 7291.8541629167385, 7293.744718934839, 1884.1144662008903, 1907.437305994735, 2168.8373371997086, 2190.8137808286274, 2226.6214743493565, 2237.3959031061604, 2241.204372447782, 2244.6520789277606, 2244.6857439958417, 2247.6179049561533, 2128.17001369466, 2223.7442694090223, 2226.543558570489, 2227.187076716995, 2231.553689262146, 2195.012244489978, 2214.833887458431, 2216.5456081503253, 2224.6218142915664, 2249.5051088760447, 2256.864588124701, 2257.345369842744, 2280.8745518996448, 2291.747907730148, 2296.3455415206586, 7306.123265208156, 7363.742269020612, 7366.668499917517, 7370.336669699753, 7373.5575865448245, 4453.131639330332, 4517.728936263835, 4521.3896124023495, 4544.931826022612, 4554.544545545452, 2887.2926133097526, 2925.458790123813, 2958.1864987128497, 2967.4658561458928, 2999.5200767877036, 954.2509130332725, 957.8563215517659, 983.621305797266, 985.0789511806483, 988.9011098890126, 9820.41077535343, 9832.754181145458, 9834.21326293902, 9838.3113182078, 9852.261080418926, 4081.3265811140827, 4107.260693075215, 4146.626803587692, 4161.063760653889, 4164.68764842638, 8520.14798520143, 8541.914580854113, 8600.913990860012, 8603.698870539502, 8603.741887743377, 4543.409356783597, 4550.7497087660495, 4573.222552166139, 4577.908441831145, 4578.793954272066, 4131.400946862748, 4142.047329114321, 4176.58234176586, 4180.979095104566, 4188.874333769992, 3210.871565137415, 3273.1980664737293, 3325.8193341363954, 3327.0018994301613, 3514.0687717754818, 1105.8562386889653, 1106.6126855600476, 1118.7426891814766, 1131.6322195286564, 1136.4090672850073, 1007.8941711120227, 1065.7708592652616, 1255.253124390986, 1291.728736965229, 1292.3473645808995, 6888.242293347727, 6951.096357473496, 6953.687084081229, 6960.79117626472, 6968.268331825086, 1085.918556108295, 1107.5680484610848, 1114.3258328711174, 1115.5537784885948, 1130.6947124276398, 5518.586106042063, 5574.9721251393485, 5576.1356989666665, 5582.469665381782, 5584.134459158756, 8267.669293228324, 8299.464599049195, 8431.156884311642, 8440.493570385797, 8550.230479256898, 8438.873416898752, 8457.365697572706, 8462.746117616358, 8475.0, 8476.49141051539, 6336.081268216083, 6534.248561415403, 6624.436922861611, 6640.269570347258, 6675.399214070757, 6777.45780337562, 6931.341522555349, 6970.0, 6982.825429364307, 6999.51003429755, 7441.10706715176, 7652.311291983749, 7669.271419215165, 7771.883421748791, 7778.0666320041955, 7770.611469426393, 7796.142424333206, 7829.843403131791, 7895.289423951872, 7935.761927142195, 6739.157605299338, 6749.797506074826, 6816.2502124767225, 6817.0, 6822.590644561342, 6175.135481032748, 6323.620582765049, 6716.0, 6891.965540172267, 6970.407515361251, 6501.837454063686, 6570.0, 6629.966850165718, 6751.088603038527, 6797.28628494001, 6489.286178520453, 6531.314212007671, 6539.967300163468, 6624.370684784938, 6643.0, 6609.669516524251, 6668.399844014062, 6672.065910772399, 6673.0, 6687.866242675216, 6070.3929607038945, 6099.573029887865, 6104.38956104386, 6112.0, 6112.17485639433, 6049.213602231682, 6144.508439324933, 6190.7214175363115, 6196.845078872884, 6214.627122372672], "unit": "score", "name": "mootools.html", "value": 4268.387327899624}, {"lowerIsBetter": false, "replicates": [333.1089336026129, 333.8330834582709, 336.70874693390226, 341.3786907827754, 342.85600047979847, 5947.316058653256, 5963.522918166547, 5974.611650242731, 6017.578769486137, 6023.668698221596, 5860.326062502802, 5905.20279762232, 5908.172855800191, 5913.704314784254, 5915.792947246837, 4592.931106033412, 4594.74728889911, 4595.724256544601, 4603.10239503297, 4616.146012987608, 4513.661475389343, 4590.013147173357, 4605.769711514427, 4607.63138948885, 4625.098105869357, 4528.796204170821, 4538.205813982539, 4540.704854184484, 4550.795214215368, 4550.795214215368, 4383.605475507188, 4481.395011673448, 4543.477500087482, 4554.886127846814, 4560.1335746208115, 3954.3475326571083, 3956.8615098471705, 4007.83968641254, 4023.034471726794, 4030.1939612077704, 5613.270274864282, 5621.0444224481935, 5621.606487545873, 5634.802781902614, 5648.576356773258, 5036.345275114249, 5151.484851514856, 5221.425643179247, 5278.313819203518, 5329.626926115174, 6302.369763023661, 6309.968450157766, 6313.779017734358, 6317.715702793339, 6332.145160403379, 4461.665375096881, 4470.26240670289, 4471.150481408522, 4471.575200355961, 4473.105378924196, 6420.5184611154355, 6467.288598254188, 6504.317046710122, 6536.084948107269, 6542.149520562344, 4568.908621827612, 4570.108828778356, 4572.0627271409285, 4572.291294849238, 4574.359589657451, 4623.583877451046, 4624.30635404692, 4624.630029597624, 4624.884377890512, 4628.95371046292, 5295.364556253275, 5299.841004769786, 5308.840734777963, 5309.867253318698, 5311.097113490716, 6192.027701964377, 6307.432331090224, 6334.809955701337, 6350.33321501245, 6355.745770169141, 1618.902865828054, 1637.8198398176191, 1638.2709694185974, 1640.8769342299374, 1641.6470458851165, 1096.6709987003867, 1121.3328069798456, 1121.8261169518737, 1128.960486382989, 1142.31461123327, 6074.635521868702, 6081.057436097323, 6087.05650624154, 6091.939080609226, 6100.755969761249, 6549.574277671936, 6555.8361040973405, 6556.442702370352, 6559.5408321418, 6563.409293163638, 5977.372375900555, 6075.149479072933, 6084.361142080018, 6086.360932102154, 6086.60437071589, 3528.947065794015, 3557.6975957043423, 3561.6972557332397, 3563.2873425315042, 3567.518385018041, 6663.200415950117, 6668.199816022011, 6672.065910772496, 6672.266050734415, 6672.5329226953645, 6415.358464153547, 6544.509161812883, 6644.0, 6670.699818508178, 6718.49611279156, 6170.259568851767, 6516.57642253252, 6624.205095388488, 6707.865842683119, 6712.39588437043, 6589.868202636017, 6590.7693230736695, 6593.505487088391, 6598.0102984552705, 6604.537682362188, 6467.482601391972, 6495.0, 6511.218653761579, 6515.218173819172, 6518.641474718936, 6571.5399922005, 6707.5304728668525, 6710.496712746466, 6720.9327906722265, 6726.899096513458, 4606.700564463299, 4607.792649330721, 4611.469680986595, 4611.815527378867, 4614.792334345029, 6573.375529324707, 6599.53803233769, 6602.273749887412, 6607.041978912935, 6610.405063544112, 6271.843203919939, 6392.93607063942, 6410.743570257324, 6432.6462044588, 6440.130582371507, 6406.967965160145, 6414.326495717883, 6419.101325814297, 6424.229092508929, 6427.3251308611925, 6300.59046161998, 6301.117843502005, 6301.275353334425, 6301.6219026858535, 6319.05214217871, 6309.432151106423, 6438.0, 6440.323766004502, 6441.291457939717, 6443.581167224115, 6283.37166283368, 6284.24589049317, 6288.5283603728985, 6290.0, 6291.559590828598], "unit": "score", "name": "prototype.html", "value": 4795.775988850809}, {"lowerIsBetter": false, "replicates": [689.8585789913068, 728.3808762551828, 784.635144657734, 800.459689709446, 815.8613035783916, 12629.557965471211, 13209.537666181686, 13213.669658258548, 13216.074874758771, 13218.471261149554, 13624.455021799116, 13783.17300961943, 13793.310334483262, 13811.447542098304, 13835.377408016639, 687.5840116729381, 688.8415664397191, 821.3347188777079, 823.9629216685233, 839.4375768235298, 828.4697793412221, 829.4649950781742, 835.1940377535677, 835.3859912963997, 835.5947365527715, 714.0788382985942, 877.1316396767187, 884.1158841158841, 885.3802338363139, 885.4908427654093, 701.7333413302938, 704.0530486495655, 708.3023222126253, 708.7944496096126, 848.9617967191491, 632.9019002054689, 635.5709895820303, 637.7385272038489, 638.4094712391067, 639.268038096377, 13144.539941102015, 13179.67050823737, 13245.139065960682, 13316.0, 13336.799948000787, 10925.726856828564, 11135.832962505569, 11551.653450396501, 11924.821127683004, 12347.691307717289, 10121.24090693201, 10278.794424111476, 10355.48222588875, 10390.116840068604, 10421.27051106423, 3656.9817150914073, 3657.817109144559, 3708.4066549351974, 3718.0890681782867, 3802.258559580883, 47695.523044769805, 48172.75913620445, 48188.0, 48228.27657585139, 48284.27573586434, 9257.49083800384, 9536.332456728102, 9626.843679917614, 9687.9031209687, 9813.509324533745, 14922.626934326729, 14958.252087395804, 14981.925090374478, 14983.175925323994, 15005.099694018176, 7353.669084891193, 7415.925840741632, 7535.246475352421, 7559.773206803805, 7563.773086807405, 4267.487901451846, 4306.870793876189, 4385.144896745104, 4408.603225709701, 4444.933326000112, 2932.545455454408, 2976.538636511344, 2981.8807247710283, 2987.1038688393396, 2987.925301867471, 557.289455943667, 583.3932709981657, 596.5436441122545, 597.3667912013279, 613.349849159892, 592.8843875444247, 644.5552568727563, 680.1600023970393, 690.226945820674, 696.5089611823652, 8383.0, 8461.111583283666, 8462.830743385099, 8637.222649961408, 8758.605862736193, 523.7669237189414, 550.782440935828, 685.5269863793966, 691.9317584781538, 713.5112447973155, 3798.601146879593, 3838.1172330363615, 3847.6537111659527, 3906.121122747416, 3912.6087391261217, 59273.0, 59489.0, 59601.0, 59653.70173149106, 59717.0, 50052.249216261785, 50935.23597146046, 51319.48680513222, 51452.22821657678, 51543.74228128835, 46569.53430465652, 46680.7665961668, 46815.5318446818, 46937.76531117323, 47261.05477890423, 7630.656620451982, 7650.349720273616, 7654.693812247448, 7787.961060194662, 7848.215178482106, 34545.82727086348, 34705.0, 34997.300053999286, 35495.82252088723, 35617.287654246255, 41910.37134442925, 43262.56737432585, 44498.3325250128, 45066.549334507545, 45917.31124033209, 9137.269018478639, 9469.147776699854, 9516.333856630246, 9623.711288661352, 9933.900660993297, 11576.131790115607, 11669.474873630877, 11835.82246266324, 11890.46492907804, 11997.160198786001, 10523.94738026305, 10593.841092383775, 10632.149428045892, 10745.462726863469, 10918.18113641496, 10272.691819245434, 10349.793004140025, 10451.529681164213, 10686.839697404701, 10697.090747286567, 7114.85770284581, 8938.290609397287, 10272.435016073889, 10389.116925061455, 10809.45952702346, 9110.863337050083, 9261.861072084059, 9272.211861991806, 9498.19265362452, 9650.662226822027, 8224.465409748347, 8789.134668197881, 9144.405613635092, 9169.908300916906, 9260.814783704154], "unit": "score", "name": "yui.html", "value": 6105.515772016992}], "name": "dromaeo_css", "value": 6781.499526484006}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 109.0, 110.0, 111.0, 99.0, 109.0, 112.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 147.0, 163.0, 126.0, 154.0, 148.0, 123.0, 157.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 161.0, 162.0, 159.0, 160.0, 165.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 78.0, 88.0, 73.0, 72.0, 71.0, 95.0, 90.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 140.0, 92.0, 93.0, 93.0, 137.0, 94.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 147.0, 147.0, 147.0, 146.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 65.0, 62.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 86.0, 87.0, 85.0, 85.0, 85.0, 87.0, 93.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [115.0, 118.0, 122.0, 111.0, 119.0, 121.0, 123.0, 123.0, 124.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [141.0, 155.0, 144.0, 149.0, 152.0, 140.0, 148.0, 149.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 69.0, 66.0, 65.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1493.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7550140891762], "unit": "score", "name": "Richards", "value": 212.97696600000003}, {"lowerIsBetter": false, "replicates": [189.25056775170324], "unit": "score", "name": "DeltaBlue", "value": 349.36751200000015}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1956.9471624266146], "unit": "score", "name": "RayTrace", "value": 378.13437900000014}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [639.2009987515605], "unit": "score", "name": "Splay", "value": 127.48884960937501}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19759.376817517285}]} 08:25:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19759.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6781.50"}}} 08:25:07 INFO - Return code: 0 08:25:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:25:07 ERROR - # TBPL SUCCESS # 08:25:07 INFO - Running post-action listener: _resource_record_post_action 08:25:07 INFO - Running post-run listener: _resource_record_post_run 08:25:08 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 28672; Write bytes: 548503552; Read time: 304; Write time: 574928 08:25:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234307584; Read time: 0; Write time: 288068 08:25:08 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 28672; Write bytes: 313176064; Read time: 304; Write time: 286804 08:25:08 INFO - Running post-run listener: _upload_blobber_files 08:25:08 INFO - Blob upload gear active. 08:25:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:25:08 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 08:25:08 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'] 08:25:08 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 08:25:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:09 INFO - (blobuploader) - INFO - Done attempting. 08:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:10 INFO - (blobuploader) - INFO - Done attempting. 08:25:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:10 INFO - Return code: 0 08:25:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:25:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5fcb31ec804011b1a5dd5eaad7b85c9d705cf67930fc539daf7cbbb831f2d8a9b0b8797e38c526af88accf36eb35e8743b8bda297ec236aa9cdd3c283425978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c94fca7c21e2f8e32fc8b291214164b0bfef0132e6a140a984095e762343b987f3fe9ba02bd7aef9708f3b00a061adff9bc7f832dd6686fcfc672145563d2cb5"} 08:25:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:25:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:25:10 INFO - Contents: 08:25:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5fcb31ec804011b1a5dd5eaad7b85c9d705cf67930fc539daf7cbbb831f2d8a9b0b8797e38c526af88accf36eb35e8743b8bda297ec236aa9cdd3c283425978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c94fca7c21e2f8e32fc8b291214164b0bfef0132e6a140a984095e762343b987f3fe9ba02bd7aef9708f3b00a061adff9bc7f832dd6686fcfc672145563d2cb5"} 08:25:10 INFO - Copying logs to upload dir... 08:25:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.874332 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-22 08:25:10.643050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:10.646903) ========= 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=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 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/d5fcb31ec804011b1a5dd5eaad7b85c9d705cf67930fc539daf7cbbb831f2d8a9b0b8797e38c526af88accf36eb35e8743b8bda297ec236aa9cdd3c283425978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c94fca7c21e2f8e32fc8b291214164b0bfef0132e6a140a984095e762343b987f3fe9ba02bd7aef9708f3b00a061adff9bc7f832dd6686fcfc672145563d2cb5"} build_url:https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/Z7nltPMHQhSZ5gvPJ3MYEg/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/d5fcb31ec804011b1a5dd5eaad7b85c9d705cf67930fc539daf7cbbb831f2d8a9b0b8797e38c526af88accf36eb35e8743b8bda297ec236aa9cdd3c283425978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c94fca7c21e2f8e32fc8b291214164b0bfef0132e6a140a984095e762343b987f3fe9ba02bd7aef9708f3b00a061adff9bc7f832dd6686fcfc672145563d2cb5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:10.671123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:10.671412) ========= 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=6587686cb2da90a5f91b3170000001be-1450799737.418399-1129944055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 08:25:10.755137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 08:25:10.755462) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 08:25:10.755764) ========= ========= Total master_lag: 0.26 =========