builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1453230013.62 results: success (0) buildid: 20160119083130 builduid: 876ec6b6a8a84efabddb7c2fd3fe8f1b revision: 74085d76282e468e6810e37de1625215e0b355a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.619671) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.620398) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.620700) ========= 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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.645816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.646171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.674487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.674866) ========= 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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035553 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.723711) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.724023) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.724379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.724938) ========= 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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 11:00:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-19 11:00:14 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.887933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.888240) ========= 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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.100477 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.998721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:13.999058) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 74085d76282e468e6810e37de1625215e0b355a3 --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 74085d76282e468e6810e37de1625215e0b355a3 --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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 11:00:14,272 truncating revision to first 12 chars 2016-01-19 11:00:14,272 Setting DEBUG logging. 2016-01-19 11:00:14,272 attempt 1/10 2016-01-19 11:00:14,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/74085d76282e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 11:00:14,514 unpacking tar archive at: fx-team-74085d76282e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:14.563061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:14.563426) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004007 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:14.613716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:14.614055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:14.624185) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:14.624452) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 11:00:14.624846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-19 11:00:14.625180) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:14 INFO - MultiFileLogger online at 20160119 11:00:14 in /builds/slave/test-pgo 11:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:00:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:00:15 INFO - {'append_to_log': False, 11:00:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:00:15 INFO - 'blob_upload_branch': 'Fx-Team', 11:00:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:00:15 INFO - 'branch': 'Fx-Team', 11:00:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:15 INFO - 'config_files': ('talos/linux_config.py',), 11:00:15 INFO - 'default_actions': ('clobber', 11:00:15 INFO - 'read-buildbot-config', 11:00:15 INFO - 'download-and-extract', 11:00:15 INFO - 'populate-webroot', 11:00:15 INFO - 'create-virtualenv', 11:00:15 INFO - 'install', 11:00:15 INFO - 'run-tests'), 11:00:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:15 INFO - 'download_minidump_stackwalk': True, 11:00:15 INFO - 'download_symbols': 'ondemand', 11:00:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:15 INFO - 'installer_path': 'installer.exe', 11:00:15 INFO - 'log_level': 'info', 11:00:15 INFO - 'log_name': 'talos', 11:00:15 INFO - 'log_to_console': True, 11:00:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:15 INFO - 'opt_config_files': (), 11:00:15 INFO - 'pip_index': False, 11:00:15 INFO - 'sps_profile': False, 11:00:15 INFO - 'sps_profile_interval': 0, 11:00:15 INFO - 'suite': 'dromaeojs', 11:00:15 INFO - 'system_bits': '32', 11:00:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:15 INFO - 'title': 'talos-linux64-ix-044', 11:00:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:15 INFO - 'use_talos_json': True, 11:00:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:00:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:15 INFO - 'work_dir': 'build'} 11:00:15 INFO - ##### 11:00:15 INFO - ##### Running clobber step. 11:00:15 INFO - ##### 11:00:15 INFO - Running pre-action listener: _resource_record_pre_action 11:00:15 INFO - Running main action method: clobber 11:00:15 INFO - rmtree: /builds/slave/test-pgo/build 11:00:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:00:19 INFO - Running post-action listener: _resource_record_post_action 11:00:19 INFO - ##### 11:00:19 INFO - ##### Running read-buildbot-config step. 11:00:19 INFO - ##### 11:00:19 INFO - Running pre-action listener: _resource_record_pre_action 11:00:19 INFO - Running main action method: read_buildbot_config 11:00:19 INFO - Using buildbot properties: 11:00:19 INFO - { 11:00:19 INFO - "project": "", 11:00:19 INFO - "product": "firefox", 11:00:19 INFO - "script_repo_revision": "production", 11:00:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:00:19 INFO - "repository": "", 11:00:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:00:19 INFO - "buildid": "20160119083130", 11:00:19 INFO - "pgo_build": "True", 11:00:19 INFO - "basedir": "/builds/slave/test-pgo", 11:00:19 INFO - "buildnumber": 428, 11:00:19 INFO - "slavename": "talos-linux64-ix-044", 11:00:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:00:19 INFO - "platform": "ubuntu64_hw", 11:00:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:00:19 INFO - "branch": "fx-team", 11:00:19 INFO - "repo_path": "integration/fx-team", 11:00:19 INFO - "revision": "74085d76282e468e6810e37de1625215e0b355a3", 11:00:19 INFO - "stage_platform": "linux64-pgo", 11:00:19 INFO - "builduid": "876ec6b6a8a84efabddb7c2fd3fe8f1b", 11:00:19 INFO - "slavebuilddir": "test" 11:00:19 INFO - } 11:00:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:00:19 INFO - Running post-action listener: _resource_record_post_action 11:00:19 INFO - ##### 11:00:19 INFO - ##### Running download-and-extract step. 11:00:19 INFO - ##### 11:00:19 INFO - Running pre-action listener: _resource_record_pre_action 11:00:19 INFO - Running main action method: download_and_extract 11:00:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:00: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')]} 11:00:19 INFO - https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/test_packages.json 11:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/test_packages.json 11:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:00:23 INFO - Downloaded 1448 bytes. 11:00:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:00:23 INFO - Using the following test package requirements: 11:00:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:00:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:00:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'jsshell-linux-x86_64.zip'], 11:00:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:00:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:00:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:00:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:00:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:00:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:00:23 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')]} 11:00:23 INFO - https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:32 INFO - Downloaded 22484667 bytes. 11:00:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:00:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:00:33 INFO - Return code: 0 11:00:33 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 11:00:33 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')]} 11:00:33 INFO - https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:35 INFO - Downloaded 22484667 bytes. 11:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:00:36 INFO - Return code: 0 11:00: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')]} 11:00:36 INFO - https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:37 INFO - Downloaded 11132144 bytes. 11:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:00:37 INFO - Return code: 0 11:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:37 INFO - https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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 11:00:39 INFO - Downloaded 55948260 bytes. 11:00:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:39 INFO - mkdir: /builds/slave/test-pgo/properties 11:00:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:00:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:00:39 INFO - Contents: 11:00:39 INFO - build_url:https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:00:39 INFO - Running post-action listener: _resource_record_post_action 11:00:39 INFO - Running post-action listener: set_extra_try_arguments 11:00:39 INFO - ##### 11:00:39 INFO - ##### Running populate-webroot step. 11:00:39 INFO - ##### 11:00:39 INFO - Running pre-action listener: _resource_record_pre_action 11:00:39 INFO - Running main action method: populate_webroot 11:00:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:39 INFO - '--tppagecycles', 11:00:39 INFO - '7'], 11:00:39 INFO - 'tests': ['tsvgm']}}, 11:00:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:00:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:00:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:00:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'tests': ['damp', 'tps']}, 11:00:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['damp', 'tps']}, 11:00:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:00:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:39 INFO - 'other': {'tests': ['a11yr', 11:00:39 INFO - 'ts_paint', 11:00:39 INFO - 'tpaint', 11:00:39 INFO - 'sessionrestore', 11:00:39 INFO - 'sessionrestore_no_auto_restore']}, 11:00:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['a11yr', 11:00:39 INFO - 'ts_paint', 11:00:39 INFO - 'tpaint', 11:00:39 INFO - 'sessionrestore', 11:00:39 INFO - 'sessionrestore_no_auto_restore']}, 11:00:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['a11yr', 11:00:39 INFO - 'ts_paint', 11:00:39 INFO - 'tpaint', 11:00:39 INFO - 'sessionrestore', 11:00:39 INFO - 'sessionrestore_no_auto_restore']}, 11:00:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['a11yr', 11:00:39 INFO - 'ts_paint', 11:00:39 INFO - 'tpaint', 11:00:39 INFO - 'sessionrestore', 11:00:39 INFO - 'sessionrestore_no_auto_restore']}, 11:00:39 INFO - 'other_l64': {'tests': ['a11yr', 11:00:39 INFO - 'ts_paint', 11:00:39 INFO - 'tpaint', 11:00:39 INFO - 'sessionrestore', 11:00:39 INFO - 'sessionrestore_no_auto_restore']}, 11:00:39 INFO - 'other_nol64': {'tests': ['a11yr', 11:00:39 INFO - 'ts_paint', 11:00:39 INFO - 'tpaint', 11:00:39 INFO - 'sessionrestore', 11:00:39 INFO - 'sessionrestore_no_auto_restore']}, 11:00:39 INFO - 'svgr': {'tests': ['tsvgx', 11:00:39 INFO - 'tsvgr_opacity', 11:00:39 INFO - 'tart', 11:00:39 INFO - 'tscrollx', 11:00:39 INFO - 'cart']}, 11:00:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['tsvgx', 11:00:39 INFO - 'tsvgr_opacity', 11:00:39 INFO - 'tart', 11:00:39 INFO - 'tscrollx', 11:00:39 INFO - 'cart']}, 11:00:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'tests': ['tp5o']}, 11:00:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'talos_options': ['--e10s'], 11:00:39 INFO - 'tests': ['tp5o']}, 11:00:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'talos_options': ['--xperf_path', 11:00:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:39 INFO - 'tests': ['tp5n']}, 11:00:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:39 INFO - 'talos_options': ['--e10s', 11:00:39 INFO - '--xperf_path', 11:00:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:39 INFO - 'tests': ['tp5n']}}, 11:00:39 INFO - 'talos.zip': {'path': '', 11:00:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:39 INFO - Running post-action listener: _resource_record_post_action 11:00:39 INFO - ##### 11:00:39 INFO - ##### Running create-virtualenv step. 11:00:39 INFO - ##### 11:00:39 INFO - Running pre-action listener: _resource_record_pre_action 11:00:39 INFO - Running main action method: create_virtualenv 11:00:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:00:39 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 11:00:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:00:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:39 INFO - Using real prefix '/usr' 11:00:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:00:39 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:41 INFO - Installing pip.................done. 11:00:41 INFO - Return code: 0 11:00:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:41 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 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:41 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 11:00:41 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 11:00:41 INFO - Using env: {'DISPLAY': ':0', 11:00:41 INFO - 'HOME': '/home/cltbld', 11:00:41 INFO - 'LANG': 'en_US.UTF-8', 11:00:41 INFO - 'LANGUAGE': 'en_US:en', 11:00:41 INFO - 'LOGNAME': 'cltbld', 11:00:41 INFO - 'MAIL': '/var/mail/cltbld', 11:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:41 INFO - 'MOZ_NO_REMOTE': '1', 11:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:41 INFO - 'NO_EM_RESTART': '1', 11:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:41 INFO - 'SHELL': '/bin/bash', 11:00:41 INFO - 'SHLVL': '1', 11:00:41 INFO - 'TERM': 'linux', 11:00:41 INFO - 'TMOUT': '86400', 11:00:41 INFO - 'USER': 'cltbld', 11:00:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:41 INFO - '_': '/tools/buildbot/bin/python'} 11:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:41 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 11:00:41 INFO - Cleaning up... 11:00:41 INFO - Return code: 0 11:00:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:41 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 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:41 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 11:00:41 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 11:00:41 INFO - Using env: {'DISPLAY': ':0', 11:00:41 INFO - 'HOME': '/home/cltbld', 11:00:41 INFO - 'LANG': 'en_US.UTF-8', 11:00:41 INFO - 'LANGUAGE': 'en_US:en', 11:00:41 INFO - 'LOGNAME': 'cltbld', 11:00:41 INFO - 'MAIL': '/var/mail/cltbld', 11:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:41 INFO - 'MOZ_NO_REMOTE': '1', 11:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:41 INFO - 'NO_EM_RESTART': '1', 11:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:41 INFO - 'SHELL': '/bin/bash', 11:00:41 INFO - 'SHLVL': '1', 11:00:41 INFO - 'TERM': 'linux', 11:00:41 INFO - 'TMOUT': '86400', 11:00:41 INFO - 'USER': 'cltbld', 11:00:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:41 INFO - '_': '/tools/buildbot/bin/python'} 11:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:42 INFO - Downloading/unpacking psutil>=0.7.1 11:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:00:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:44 INFO - Installing collected packages: psutil 11:00:44 INFO - Running setup.py install for psutil 11:00:44 INFO - building 'psutil._psutil_linux' extension 11:00:44 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 11:00:44 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 11:00:44 INFO - building 'psutil._psutil_posix' extension 11:00:44 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 11:00:44 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 11:00:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:44 INFO - Successfully installed psutil 11:00:44 INFO - Cleaning up... 11:00:44 INFO - Return code: 0 11:00:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:00:44 INFO - Using env: {'DISPLAY': ':0', 11:00:44 INFO - 'HOME': '/home/cltbld', 11:00:44 INFO - 'LANG': 'en_US.UTF-8', 11:00:44 INFO - 'LANGUAGE': 'en_US:en', 11:00:44 INFO - 'LOGNAME': 'cltbld', 11:00:44 INFO - 'MAIL': '/var/mail/cltbld', 11:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:44 INFO - 'MOZ_NO_REMOTE': '1', 11:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:44 INFO - 'NO_EM_RESTART': '1', 11:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:44 INFO - 'SHELL': '/bin/bash', 11:00:44 INFO - 'SHLVL': '1', 11:00:44 INFO - 'TERM': 'linux', 11:00:44 INFO - 'TMOUT': '86400', 11:00:44 INFO - 'USER': 'cltbld', 11:00:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:44 INFO - '_': '/tools/buildbot/bin/python'} 11:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:00:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:00:46 INFO - Installing collected packages: mozsystemmonitor 11:00:46 INFO - Running setup.py install for mozsystemmonitor 11:00:46 INFO - Successfully installed mozsystemmonitor 11:00:46 INFO - Cleaning up... 11:00:46 INFO - Return code: 0 11:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:46 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 11:00:46 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 11:00:46 INFO - Using env: {'DISPLAY': ':0', 11:00:46 INFO - 'HOME': '/home/cltbld', 11:00:46 INFO - 'LANG': 'en_US.UTF-8', 11:00:46 INFO - 'LANGUAGE': 'en_US:en', 11:00:46 INFO - 'LOGNAME': 'cltbld', 11:00:46 INFO - 'MAIL': '/var/mail/cltbld', 11:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:46 INFO - 'MOZ_NO_REMOTE': '1', 11:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:46 INFO - 'NO_EM_RESTART': '1', 11:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:46 INFO - 'SHELL': '/bin/bash', 11:00:46 INFO - 'SHLVL': '1', 11:00:46 INFO - 'TERM': 'linux', 11:00:46 INFO - 'TMOUT': '86400', 11:00:46 INFO - 'USER': 'cltbld', 11:00:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:46 INFO - '_': '/tools/buildbot/bin/python'} 11:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:46 INFO - Downloading/unpacking blobuploader==1.2.4 11:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:48 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:48 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 11:00:48 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 11:00:48 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 11:00:48 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 11:00:48 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 11:00:48 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 11:00:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:00:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:49 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 11:00:49 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 11:00:49 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 11:00:49 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 11:00:49 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 11:00:49 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 11:00:49 INFO - Downloading docopt-0.6.1.tar.gz 11:00:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:00:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:49 INFO - Running setup.py install for blobuploader 11:00:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:00:49 INFO - Running setup.py install for requests 11:00:49 INFO - Running setup.py install for docopt 11:00:49 INFO - Successfully installed blobuploader requests docopt 11:00:49 INFO - Cleaning up... 11:00:50 INFO - Return code: 0 11:00:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:50 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 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:50 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 11:00:50 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 11:00:50 INFO - Using env: {'DISPLAY': ':0', 11:00:50 INFO - 'HOME': '/home/cltbld', 11:00:50 INFO - 'LANG': 'en_US.UTF-8', 11:00:50 INFO - 'LANGUAGE': 'en_US:en', 11:00:50 INFO - 'LOGNAME': 'cltbld', 11:00:50 INFO - 'MAIL': '/var/mail/cltbld', 11:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:50 INFO - 'MOZ_NO_REMOTE': '1', 11:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:50 INFO - 'NO_EM_RESTART': '1', 11:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:50 INFO - 'SHELL': '/bin/bash', 11:00:50 INFO - 'SHLVL': '1', 11:00:50 INFO - 'TERM': 'linux', 11:00:50 INFO - 'TMOUT': '86400', 11:00:50 INFO - 'USER': 'cltbld', 11:00:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:50 INFO - '_': '/tools/buildbot/bin/python'} 11:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:50 INFO - Running setup.py (path:/tmp/pip-_AkHQO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:50 INFO - Running setup.py (path:/tmp/pip-tW4mPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:50 INFO - Running setup.py (path:/tmp/pip-ryvD9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:50 INFO - Running setup.py (path:/tmp/pip-P0XF0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:50 INFO - Running setup.py (path:/tmp/pip-cgfxGv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:50 INFO - Running setup.py (path:/tmp/pip-g70rwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:50 INFO - Running setup.py (path:/tmp/pip-tXLZr3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:50 INFO - Running setup.py (path:/tmp/pip-vcCU29-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:50 INFO - Running setup.py (path:/tmp/pip-1imwMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:50 INFO - Running setup.py (path:/tmp/pip-eZOdcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:50 INFO - Running setup.py (path:/tmp/pip-x5ab3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:51 INFO - Running setup.py (path:/tmp/pip-M08Wwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:51 INFO - Running setup.py (path:/tmp/pip-IRl78K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:51 INFO - Running setup.py (path:/tmp/pip-0EMTXv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:51 INFO - Running setup.py (path:/tmp/pip-p6zWWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:51 INFO - Running setup.py (path:/tmp/pip-c5LfI7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:51 INFO - Running setup.py (path:/tmp/pip-rbpHsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:00:51 INFO - Running setup.py install for manifestparser 11:00:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:00:51 INFO - Running setup.py install for mozcrash 11:00:51 INFO - Running setup.py install for mozdebug 11:00:51 INFO - Running setup.py install for mozdevice 11:00:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:00:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:00:51 INFO - Running setup.py install for mozfile 11:00:51 INFO - Running setup.py install for mozhttpd 11:00:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Running setup.py install for mozinfo 11:00:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Running setup.py install for mozInstall 11:00:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Running setup.py install for mozleak 11:00:52 INFO - Running setup.py install for mozlog 11:00:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Running setup.py install for moznetwork 11:00:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Running setup.py install for mozprocess 11:00:52 INFO - Running setup.py install for mozprofile 11:00:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Running setup.py install for mozrunner 11:00:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:00:52 INFO - Running setup.py install for mozscreenshot 11:00:53 INFO - Running setup.py install for moztest 11:00:53 INFO - Running setup.py install for mozversion 11:00:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:00:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:53 INFO - Cleaning up... 11:00:53 INFO - Return code: 0 11:00:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 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 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:53 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 11:00:53 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 11:00:53 INFO - Using env: {'DISPLAY': ':0', 11:00:53 INFO - 'HOME': '/home/cltbld', 11:00:53 INFO - 'LANG': 'en_US.UTF-8', 11:00:53 INFO - 'LANGUAGE': 'en_US:en', 11:00:53 INFO - 'LOGNAME': 'cltbld', 11:00:53 INFO - 'MAIL': '/var/mail/cltbld', 11:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:53 INFO - 'MOZ_NO_REMOTE': '1', 11:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:53 INFO - 'NO_EM_RESTART': '1', 11:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:53 INFO - 'SHELL': '/bin/bash', 11:00:53 INFO - 'SHLVL': '1', 11:00:53 INFO - 'TERM': 'linux', 11:00:53 INFO - 'TMOUT': '86400', 11:00:53 INFO - 'USER': 'cltbld', 11:00:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:53 INFO - '_': '/tools/buildbot/bin/python'} 11:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:53 INFO - Running setup.py (path:/tmp/pip-y_x2J8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:00:53 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)) 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:53 INFO - Running setup.py (path:/tmp/pip-c7JzVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:00:53 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)) 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:53 INFO - Running setup.py (path:/tmp/pip-lyXJEF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:00:53 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)) 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:53 INFO - Running setup.py (path:/tmp/pip-sKt7_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:53 INFO - Running setup.py (path:/tmp/pip-h6Rqgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:00:53 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)) 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:53 INFO - Running setup.py (path:/tmp/pip-RrB_WN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:00:53 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)) 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:53 INFO - Running setup.py (path:/tmp/pip-UGDb5k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:00:53 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)) 11:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:53 INFO - Running setup.py (path:/tmp/pip-6Qi1oA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:54 INFO - Running setup.py (path:/tmp/pip-iKM3tN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:54 INFO - Running setup.py (path:/tmp/pip-3aPS3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:54 INFO - Running setup.py (path:/tmp/pip-zZ8Lk4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:54 INFO - Running setup.py (path:/tmp/pip-8fVuke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:54 INFO - Running setup.py (path:/tmp/pip-88uJ_9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:54 INFO - Running setup.py (path:/tmp/pip-JOoTtI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:54 INFO - Running setup.py (path:/tmp/pip-pkNC8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:54 INFO - Running setup.py (path:/tmp/pip-1qeEgP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:00:54 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)) 11:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:54 INFO - Running setup.py (path:/tmp/pip-JA32Iv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:00:54 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)) 11:00:54 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)) 11:00:54 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)) 11:00:54 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)) 11:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:54 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:00:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:56 INFO - Downloading blessings-1.5.1.tar.gz 11:00:56 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 11:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:56 INFO - Installing collected packages: blessings 11:00:56 INFO - Running setup.py install for blessings 11:00:56 INFO - Successfully installed blessings 11:00:56 INFO - Cleaning up... 11:00:56 INFO - Return code: 0 11:00:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:00:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:00:56 INFO - Reading from file tmpfile_stdout 11:00:56 INFO - Current package versions: 11:00:56 INFO - argparse == 1.2.1 11:00:56 INFO - blessings == 1.5.1 11:00:56 INFO - blobuploader == 1.2.4 11:00:56 INFO - docopt == 0.6.1 11:00:56 INFO - manifestparser == 1.1 11:00:56 INFO - mozInstall == 1.12 11:00:56 INFO - mozcrash == 0.16 11:00:56 INFO - mozdebug == 0.1 11:00:56 INFO - mozdevice == 0.48 11:00:56 INFO - mozfile == 1.2 11:00:56 INFO - mozhttpd == 0.7 11:00:56 INFO - mozinfo == 0.9 11:00:56 INFO - mozleak == 0.1 11:00:56 INFO - mozlog == 3.1 11:00:56 INFO - moznetwork == 0.27 11:00:56 INFO - mozprocess == 0.22 11:00:56 INFO - mozprofile == 0.28 11:00:56 INFO - mozrunner == 6.11 11:00:56 INFO - mozscreenshot == 0.1 11:00:56 INFO - mozsystemmonitor == 0.0 11:00:56 INFO - moztest == 0.7 11:00:56 INFO - mozversion == 1.4 11:00:56 INFO - psutil == 3.1.1 11:00:56 INFO - requests == 1.2.3 11:00:56 INFO - wsgiref == 0.1.2 11:00:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:56 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 11:00:56 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 11:00:56 INFO - Using env: {'DISPLAY': ':0', 11:00:56 INFO - 'HOME': '/home/cltbld', 11:00:56 INFO - 'LANG': 'en_US.UTF-8', 11:00:56 INFO - 'LANGUAGE': 'en_US:en', 11:00:56 INFO - 'LOGNAME': 'cltbld', 11:00:56 INFO - 'MAIL': '/var/mail/cltbld', 11:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:56 INFO - 'MOZ_NO_REMOTE': '1', 11:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:56 INFO - 'NO_EM_RESTART': '1', 11:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:56 INFO - 'SHELL': '/bin/bash', 11:00:56 INFO - 'SHLVL': '1', 11:00:56 INFO - 'TERM': 'linux', 11:00:56 INFO - 'TMOUT': '86400', 11:00:56 INFO - 'USER': 'cltbld', 11:00:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:56 INFO - '_': '/tools/buildbot/bin/python'} 11:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 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)) 11:00:57 INFO - Cleaning up... 11:00:57 INFO - Return code: 0 11:00:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:00:57 INFO - Using env: {'DISPLAY': ':0', 11:00:57 INFO - 'HOME': '/home/cltbld', 11:00:57 INFO - 'LANG': 'en_US.UTF-8', 11:00:57 INFO - 'LANGUAGE': 'en_US:en', 11:00:57 INFO - 'LOGNAME': 'cltbld', 11:00:57 INFO - 'MAIL': '/var/mail/cltbld', 11:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:57 INFO - 'MOZ_NO_REMOTE': '1', 11:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:57 INFO - 'NO_EM_RESTART': '1', 11:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:57 INFO - 'SHELL': '/bin/bash', 11:00:57 INFO - 'SHLVL': '1', 11:00:57 INFO - 'TERM': 'linux', 11:00:57 INFO - 'TMOUT': '86400', 11:00:57 INFO - 'USER': 'cltbld', 11:00:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:57 INFO - '_': '/tools/buildbot/bin/python'} 11:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:57 INFO - Downloading/unpacking jsonschema 11:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:59 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 11:00:59 INFO - Downloading/unpacking functools32 (from jsonschema) 11:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:59 INFO - warning: no files found matching '*.txt' 11:00:59 INFO - no previously-included directories found matching 'build' 11:00:59 INFO - no previously-included directories found matching 'dist' 11:00:59 INFO - no previously-included directories found matching '.git*' 11:00:59 INFO - Installing collected packages: jsonschema, functools32 11:00:59 INFO - Running setup.py install for functools32 11:00:59 INFO - warning: no files found matching '*.txt' 11:00:59 INFO - no previously-included directories found matching 'build' 11:00:59 INFO - no previously-included directories found matching 'dist' 11:00:59 INFO - no previously-included directories found matching '.git*' 11:00:59 INFO - Successfully installed jsonschema functools32 11:00:59 INFO - Cleaning up... 11:00:59 INFO - Return code: 0 11:00:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d64204f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2962630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', '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 11:00:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:00:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:00:59 INFO - Using env: {'DISPLAY': ':0', 11:00:59 INFO - 'HOME': '/home/cltbld', 11:00:59 INFO - 'LANG': 'en_US.UTF-8', 11:00:59 INFO - 'LANGUAGE': 'en_US:en', 11:00:59 INFO - 'LOGNAME': 'cltbld', 11:00:59 INFO - 'MAIL': '/var/mail/cltbld', 11:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:59 INFO - 'MOZ_NO_REMOTE': '1', 11:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:59 INFO - 'NO_EM_RESTART': '1', 11:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:59 INFO - 'SHELL': '/bin/bash', 11:00:59 INFO - 'SHLVL': '1', 11:00:59 INFO - 'TERM': 'linux', 11:00:59 INFO - 'TMOUT': '86400', 11:00:59 INFO - 'USER': 'cltbld', 11:00:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:59 INFO - '_': '/tools/buildbot/bin/python'} 11:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:59 INFO - Downloading/unpacking flake8 11:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:01:01 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 11:01:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:01:01 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 11:01:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:01 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 11:01:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:01:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:02 INFO - no previously-included directories found matching 'docs/_build' 11:01:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:01:02 INFO - Running setup.py install for pep8 11:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:02 INFO - no previously-included directories found matching 'docs/_build' 11:01:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:01:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:01:02 INFO - Cleaning up... 11:01:02 INFO - Return code: 0 11:01:02 INFO - Running post-action listener: _resource_record_post_action 11:01:02 INFO - Running post-action listener: _start_resource_monitoring 11:01:02 INFO - Starting resource monitoring. 11:01:02 INFO - ##### 11:01:02 INFO - ##### Running install step. 11:01:02 INFO - ##### 11:01:02 INFO - Running pre-action listener: _resource_record_pre_action 11:01:02 INFO - Running main action method: install 11:01:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:01:02 INFO - Reading from file tmpfile_stdout 11:01:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:01:02 INFO - Reading from file tmpfile_stdout 11:01:02 INFO - Output received: 11:01:02 INFO - Usage: mozinstall [options] installer 11:01:02 INFO - Options: 11:01:02 INFO - -h, --help show this help message and exit 11:01:02 INFO - -d DEST, --destination=DEST 11:01:02 INFO - Directory to install application into. [default: 11:01:02 INFO - "/builds/slave/test-pgo"] 11:01:02 INFO - --app=APP Application being installed. [default: firefox] 11:01:02 INFO - mkdir: /builds/slave/test-pgo/build/application 11:01:02 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'] 11:01:02 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 11:01:18 INFO - Reading from file tmpfile_stdout 11:01:18 INFO - Output received: 11:01:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:01:18 INFO - Running post-action listener: _resource_record_post_action 11:01:18 INFO - ##### 11:01:18 INFO - ##### Running run-tests step. 11:01:18 INFO - ##### 11:01:18 INFO - Running pre-action listener: _resource_record_pre_action 11:01:18 INFO - Running main action method: run_tests 11:01:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:01:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:01:18 INFO - Python 2.7.3 11:01:18 INFO - Return code: 0 11:01:18 INFO - grabbing minidump binary from tooltool 11:01:18 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')]} 11:01:18 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 0x29f3840>, '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 0x29606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2960b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:01:18 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 11:01:18 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 11:01:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:18 INFO - Return code: 0 11:01:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:01:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:01:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:01:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:01:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:01:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:01:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:01:19 INFO - Return code: 0 11:01:19 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/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 11:01:19 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/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 11:01:19 INFO - Using env: {'DISPLAY': ':0', 11:01:19 INFO - 'HOME': '/home/cltbld', 11:01:19 INFO - 'LANG': 'en_US.UTF-8', 11:01:19 INFO - 'LANGUAGE': 'en_US:en', 11:01:19 INFO - 'LOGNAME': 'cltbld', 11:01:19 INFO - 'MAIL': '/var/mail/cltbld', 11:01:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:01:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:19 INFO - 'MOZ_NO_REMOTE': '1', 11:01:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:19 INFO - 'NO_EM_RESTART': '1', 11:01:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:01:19 INFO - 'SHELL': '/bin/bash', 11:01:19 INFO - 'SHLVL': '1', 11:01:19 INFO - 'TERM': 'linux', 11:01:19 INFO - 'TMOUT': '86400', 11:01:19 INFO - 'USER': 'cltbld', 11:01:19 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245', 11:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:19 INFO - '_': '/tools/buildbot/bin/python'} 11:01:19 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/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 11:01:19 INFO - mozversion application_buildid: 20160119083130 11:01:19 INFO - mozversion application_changeset: 74085d76282e468e6810e37de1625215e0b355a3 11:01:19 INFO - mozversion application_display_name: Nightly 11:01:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:19 INFO - mozversion application_name: Firefox 11:01:19 INFO - mozversion application_remotingname: firefox 11:01:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:01:19 INFO - mozversion application_vendor: Mozilla 11:01:19 INFO - mozversion application_version: 46.0a1 11:01:19 INFO - mozversion platform_buildid: 20160119083130 11:01:19 INFO - mozversion platform_changeset: 74085d76282e468e6810e37de1625215e0b355a3 11:01:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:01:19 INFO - mozversion platform_version: 46.0a1 11:01:19 INFO - using testdate: 1453230079 11:01:19 INFO - actual date: 1453230079 11:01:19 INFO - starting webserver on 'localhost:59828' 11:01:19 INFO - SUITE-START | Running 3 tests 11:01:19 INFO - TEST-START | dromaeo_css 11:01:19 INFO - operating with platform_type : linux_ 11:01:19 INFO - Initialising browser for dromaeo_css test... 11:01:19 INFO - TEST-INFO | started process 25603 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqbAbb8/profile http://localhost:59828/getInfo.html) 11:01:24 INFO - PROCESS | 25603 | __metrics Screen width/height:1600/1200 11:01:24 INFO - PROCESS | 25603 | colorDepth:24 11:01:24 INFO - PROCESS | 25603 | Browser inner width/height: 1024/697 11:01:24 INFO - PROCESS | 25603 | __metrics 11:01:24 INFO - PROCESS | 25603 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:01:24 INFO - PROCESS | 25603 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:25 INFO - TEST-INFO | 25603: exit 0 11:01:25 INFO - Browser initialized. 11:01:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:25 INFO - TEST-INFO | started process 25697 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqbAbb8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:37 INFO - PROCESS | 25697 | RSS: Main: 149385216 11:01:37 INFO - PROCESS | 25697 | 11:02:28 INFO - PROCESS | 25697 | 1453230148361 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] 11:04:36 INFO - PROCESS | 25697 | Cycle 1(1): loaded http://localhost:59828/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59828/tests/dromaeo/cssquery-ext.html) 11:04:37 INFO - PROCESS | 25697 | RSS: Main: 287805440 11:04:37 INFO - PROCESS | 25697 | 11:07:40 INFO - PROCESS | 25697 | Cycle 1(1): loaded http://localhost:59828/tests/dromaeo/cssquery-ext.html (next: http://localhost:59828/tests/dromaeo/cssquery-jquery.html) 11:07:40 INFO - PROCESS | 25697 | RSS: Main: 236400640 11:07:40 INFO - PROCESS | 25697 | 11:10:42 INFO - PROCESS | 25697 | Cycle 1(1): loaded http://localhost:59828/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59828/tests/dromaeo/cssquery-mootools.html) 11:10:43 INFO - PROCESS | 25697 | RSS: Main: 228831232 11:10:43 INFO - PROCESS | 25697 | 11:13:45 INFO - PROCESS | 25697 | Cycle 1(1): loaded http://localhost:59828/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59828/tests/dromaeo/cssquery-prototype.html) 11:13:45 INFO - PROCESS | 25697 | RSS: Main: 211628032 11:13:45 INFO - PROCESS | 25697 | 11:16:48 INFO - PROCESS | 25697 | Cycle 1(1): loaded http://localhost:59828/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59828/tests/dromaeo/cssquery-yui.html) 11:16:48 INFO - PROCESS | 25697 | RSS: Main: 216158208 11:16:48 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | Cycle 1(1): loaded http://localhost:59828/tests/dromaeo/cssquery-yui.html (next: http://localhost:59828/tests/dromaeo/cssquery-dojo.html) 11:19:51 INFO - PROCESS | 25697 | RSS: Main: 269156352 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | __start_tp_report 11:19:51 INFO - PROCESS | 25697 | _x_x_mozilla_page_load 11:19:51 INFO - PROCESS | 25697 | _x_x_mozilla_page_load_details 11:19:51 INFO - PROCESS | 25697 | |i|pagename|runs| 11:19:51 INFO - PROCESS | 25697 | |0;dojo.html;3107.766917481189;3135.0594821553527;3182.6339970903337;3195.888143914965;3210.871565137394;4958;5056.797728090881;5139.229115632652;5164.767585458654;5212.661177023496;5075.416327122382;5097.59219262459;5101.617378696594;5107.668001579904;5162.045021670993;4680.882977925562;4707.05858828234;4729.077829823186;4741.7154970701695;4819.108464933998;527.7755799009032;4595.862124136282;4693.9061218775605;4732.432108147027;4761.262004389308;4621.560951709599;4687.460941991663;4729.172394830891;4770.1413745525615;4773.928391074137;4693.178693728584;4707.38803955487;4709.835155769566;4716.481187069454;4755.476897541268;4515.819367225307;4642.489326174118;4682.531746825291;4713.316569097496;4758.738269395217;4891.559759621616;4924.4090709115135;4981.227909674007;4990.126727822617;5014.448410674823;5403.13549832025;5406.270153529263;5407.486288802596;5410.594205434608;5415.431379705114;5360.919586206171;5429.592780541475;5431.665261782355;5459.754311056012;5473.8357849264585;5146.356705411824;5155.329807125087;5161.406438259611;5186.118359878829;5236.764345604457;5561.277033985556;5565.0817615093865;5585.58108141891;5588.133839254922;5609.411011843779;5200;5395.919061214085;5399.568034557226;5402.756875940592;5403.459654034644;5444.074507333763;5479.2602998594675;5491.752871120809;5495.2856128703015;5537.086380747131;5418.512333889968;5466.671999680032;5470.152126420411;5470.7264636768;5488.204210389471;5272.446393128743;5361.5710743141235;5461.290032295856;5476.534494567926;5513.972430137824;4267.1892340455215;4298.742075475481;4316.6330861877095;4334.45819272591;4354.695171337976;3829.387298032357;3857.3442514772555;3863.0535518798074;3895.902602434962;3906.2382835347403;5025.623078269145;5105.514976077341;5106.897862042739;5112.846614601568;5119.48805119485;5407.729613519308;5471.23402723619;5490.752916118784;5496.835094947078;5539.307586551681;5116.386033675983;5131.358580177478;5136.203888397305;5146.202338637517;5181.093308670967;4676.532346765296;4709.434867815884;4754.667173297836;4755.001449695603;4763.142634325785;5771.971140144273;5785.681787501728;5800.24596802413;5803.332616749043;5804.1293805929445;5564.777408903598;5584.134459158837;5584.832455026356;5585.301837270341;5589.413111623384;5609.382967873449;5679.460451257124;5746.540276777764;5762.538996880324;5773.364929857797;5395.78416863321;5399.676019438846;5410.350757908918;5415.48552887475;5418.620696551204;5478.726063696879;5483.2323474712775;5485.341758988947;5487.6981766003255;5533.004059269209;5262.815801447084;5336.946630533645;5372.435894231049;5414.242006119068;5417.133258678593;5378.784848606168;5381.8923621526565;5387.191921211849;5389;5423;5284.339457567804;5287.206918962186;5290.629655924048;5291.523762861361;5338.332708411449;5275.1032324505695;5380;5381.67709937405;5393.784248630011;5419.83740487786;5234.13636749932;5264;5265.21021846726;5265.657732247391;5317.787288508571 11:19:51 INFO - PROCESS | 25697 | |1;ext.html;516.1586613819474;524.7350088205458;527.2328761651797;551.5615086006625;568.2924758675448;28531;28650.570241446396;28853.27866803331;28854.85572572137;28918.529776426807;29324.706752932463;37391.81304093482;37988.24023519528;38008.80995595025;38076;8360.790980225482;8499.787505312386;8512.659493620247;8514.48913065218;8524.914750852506;8152.836943261132;8285.212904774067;8293.253607175353;8373.12082231366;8385.329173666123;8370.204830541088;8402.621882015324;8428.747137585882;8436;8456.492610443393;8292.626831792553;8546.2308392245;8572.957135214347;8590.098039705867;8597.398182127254;8454.661813527451;8518.446300990478;8521.616527256288;8588.570571471402;8590.957045214796;39977.20330552083;40461.39307910384;40488.190236195405;40530.189396212205;40554.97225138731;3141.6387115481784;3231.87072517099;3289.5723555937816;3524.7708898921487;3668.137987572918;30242.69757302421;30457;30756;30994.535081973787;31728.841355793305;3562.7684200526883;3568.678818906311;3702.4446333049987;3774.6225377462033;3775.339315619756;260687;261732.691336544;261782;263937;264647;50548.24177637338;51810.48189518132;58542.707286463294;59059.70470147622;59466.405335946954;53757.46242537525;53925.46074539205;54021;54086.18870716942;54207.72896135573;12235.265884046985;14892.404303827941;15023.849761502464;15063.17152556598;15074.321655525528;8671.21959023691;10978.505967231495;11278.943605282086;11292.54829806815;11330.886691133148;19274.32539861098;19434.959329270223;19552.90223548873;19553;19570.90214548918;6950.930490695129;7312.1956584775635;7410.258974102547;7436.888446673304;7495.175530691619;918.820829938169;1017.6946915925192;1024.032289486443;1036.657902892044;1038.6624347087077;24895.253142405756;25535.61696574553;25585.48829023409;25634.35914102125;25740.227793166236;1007.5919252702668;1043.3479075577764;1076.5908954597203;1135.517405102828;1137.2494153858413;13536.255505947267;13764.862351376358;13912.721745565032;14011.369488373048;14014.579562613138;333484;333836;339123;339179;340251;52021;52384;52677.209841852404;52687.473125269025;52735.736321318145;1295.5400832704443;1306.4186437035428;1308.3915979069777;1315.500109958229;1335.3857225676104;24069.796510174772;24337.634935475628;25743.227703168934;26089.478210436064;27683.508484236514;42412.575874240865;42811;42835.57164428316;42846.78576607097;42865.35701964411;187661;187697;187948;188118;188793;29106.708932911246;32018;32558.83720581382;33016.174595635304;33021.17447063747;37631.2473750518;38075;38830.2233955325;39015.6098439012;41102.1779564413;34639.480407794406;34822.47766283457;34927.476087858195;35559.46660800038;37057;32320.515192272604;32358.514622280214;32537.511937320487;32667.836660816545;32807;32279.35441291208;32784.67215327816;32953.681852725626;32960.83519582387;33055.66944330526;28814.423711526073;29408.676609552193;30177.396452071276;32023.839880800446;33291;24397.634035489125;24577.262682119566;24654.383640409134;24765.87617061903;24961.375965601004 11:19:51 INFO - PROCESS | 25697 | |2;jquery.html;354.4842254519674;355.89501097176344;358.60016082068483;361.3207170519423;362.21760996248105;13206.339683015834;13554;15515.767263491043;16000.199990000498;16974.066426346562;15389.69220615587;15440.922795386008;15980.200989950514;16068.357265709357;16081.83918160818;4952.479989601094;5339.866503337409;5342.572594192456;5345.893082138355;5353.705546194958;3992.2215168042244;4126.154138401621;4126.958730412703;5230.607704422184;5738.42615738427;5103.719295438749;5833.970830145843;5885.7939972100985;5890.469857712805;5891.057430811071;5231.790728370861;5236.266922630834;5243.187305967543;5262.710550919698;5278.788848446057;4943.431505376856;5071.695698258116;5093.668911520739;5095.133827249339;5118.718470484122;12622.74754504914;12842.101052926299;13143.671408214872;13203.075784695075;13234.27211503367;1971.2213675598202;1998.7901270366547;2059.1351632314313;2065.2874758208395;2168.4253672776726;9469.621215151386;9512;9669.17811985982;9832.754181145528;9862.408255504693;1779.5373202967191;1821.289697018164;1821.4535639308156;1839.7424360589393;1907.2466375781628;54676.45323546753;55093.724531377484;55208;56223;56811.43188568144;9855.45794981283;10020.148287395506;10111.797764044824;10112.443815590066;10182.847257291147;13280.73438531224;13302.334883255991;13379.464821407035;13401.262930538915;13414.731705365837;7371.299726525972;7391.260873912565;7407.703691852374;7455.589942553212;7533.20901305366;6936.445084393236;6975.058367120475;6996.860062798817;6997.230304666483;7133.96433017842;4010.5588385277597;4385.978070109629;4438.090191510732;4461.7992190351515;4502.50472448037;1749.3877143000102;1780.3946658136297;1783.8394544490798;1787.1868299923503;1798.5323815807722;971.5725080964353;973.0339078584315;974.4153507895206;988.9764094162507;1009.7324209084599;15367.692646147014;16033.759493607606;16140.354385824436;16604.086775227235;16660.50018499447;931.1340453378423;931.3015238571072;938.2681508423441;952.5999080386255;974.8732664753537;8020.478668886503;9314.254859611216;9317.534123293808;9421.340506164503;9514.666986655433;546839;547284;551882;573218;573782;61811;66252;69156.30843691599;70405;71331.2866871335;1109.0794640448407;1119.9832002519968;1126.4705588373452;1144.66804626659;1146.7591805720892;15204.923975380052;15309;15448.30482628262;15491.07053576789;15678.76481852796;32388.514172287905;32680.67319326776;32698.673013269563;33351;33976.3204735899;37768.244635107694;40678.59321406748;41008.79495602622;41265;41788.16423671449;6985.26654701249;7381.483296169216;7399.704011839682;7468.887966680395;7579.962100189464;10627.309224900357;11179.385133817717;11186.105111591216;11187.16096292765;11409.201355905006;7117.6085315308155;9196.448213107235;9333.719988400358;9605.327627066039;9679.564419601276;9171.44971301724;9431.339806213498;9694.246923130448;9745.463999480096;9919.15687166599;7672.769816905502;9305.488198148896;9366.438013718926;9737.367071140354;9764.365316254421;7202.207757146814;7416.221296763762;7452.403807695263;7464.962675186589;7478.551286922802;8724.738257852274;10170;10188.235882309005;10294.433806140734;10360.067593916583 11:19:51 INFO - PROCESS | 25697 | |3;mootools.html;1298.2599918046706;1412.8163338765962;1419.2761691537316;1542.4293011585708;1742.033171589768;6961.651917404135;7248.4563657725685;7368.226336234685;7383.4831561790625;7392.741254056109;7439.702411903518;7519.172890981988;7557.58433286169;7578.810529736746;7595.088589369269;1935.8451323894126;1966.7541557305337;2255.1881322723807;2277.999999999996;2293.025464177726;2329.801966832821;2332.5334933013382;2344.2264052862515;2351.623740201568;2353.6940197774265;2256.0524579676494;2307.8038366738765;2313.8843057847125;2315.2475445480286;2317.6639387288833;2215.8920539730134;2240.0815665577115;2330.7203135623663;2335.6262997920253;2338.6608941703444;2283.794458498743;2284.657301404786;2305.5388922215457;2309.8960546775434;2338.275134708246;7720.575368354738;7798.064232292161;7813.17961614028;7818.609069546556;7819.882701759479;4720.811167553294;4857.441394239672;4861.246506791453;4870.975645121787;4877.951220487786;3072.738817200541;3112.750979921601;3172.5406313096005;3173.0639461358955;3191.48936170214;1000.9551858632484;1018.6180182431589;1064.5741703318656;1081.859358283418;1084.2301965604431;10733.516991735312;10753.731156721145;10755.892441075646;10757.408342541157;10760.139188864872;4371.912561748811;4386.539413361615;4439.778011099432;4451.310046942729;4462.799174037176;8631.482111073356;8718.82562348762;8720.084391138838;8720.78198045054;8727.432716873383;4754.667173297905;4789.137955168034;4792.113459010095;4795.376601041842;4799.616030717534;4447.421835161408;4451.666125040635;4452.710573812692;4452.8218871245435;4457.7102488338805;3327.334533093391;3366.6296707362662;3505.298940211968;3521.2253304273017;3552.8223588820974;1072.5548897207727;1086.5653738504661;1087.244365166202;1089.4008295437477;1097.6871591596516;1014.4369874719454;1044.2064031336088;1044.3264094658903;1135.5911871726173;1261.0164072023836;7324.926750732531;7409;7448.180700122982;7459.925400745923;7469.402447804163;1094.1083017341;1097.4622435006788;1104.447776111944;1111.111111111124;1131.4173200801595;5578.665280083208;5630.802921897796;5665.773369065191;5667.036603777367;5669.064604340238;9424.95287523558;9533.094356036165;9658.951705241428;9678.17735492477;9830.75423114428;9498.90501094994;9610.087041731025;9649.179819715402;9659.758506037264;9676.12914837668;7451.85096298071;7492.550446973199;7499.400047996147;7548.433867459962;7582.507137036075;7213.314735100157;7220.74727384539;7233;7248.0939882514685;7270.200277969313;8368.288695460955;8472.61873215719;8509.74470765878;8572.657093716181;8729.694460693845;8618.267447267053;8918.643254269757;8973.147550982647;9003.90996090057;9010.90989090127;5975.641461512323;6644.069830223869;6763.695633696397;6781.694823732845;6783.219929708147;6757.662116894234;6790.117284753148;6793.932060679527;7197.424206063607;7381.926180738339;6958.8956165658565;6981.441484681315;7016.228214896255;7024.192217894803;7081.787546373617;6937.89593156093;6938.340857618518;6939.201991771011;6968.477364197604;7024;6680.432163266177;6706.497012724163;6722.731090756315;6733.595984240961;6741.1236539249585;6448.742050317935;6471.320511346429;6490.091387205701;6493.448056915215;6500.284968653539;6659.300773418721;6673.299303573249;6703.363180497845;6712.731490740511;6713.227978782503 11:19:51 INFO - PROCESS | 25697 | |4;prototype.html;341.4485605746719;346.5183395080838;350.11421104605347;350.6458476938292;352.4273056283539;5817.941820581793;5903.911441328378;5937.88124237515;5941.970290148549;6023.939760602393;5727.885442291152;5875.853103672411;5890.852728681774;5907.202527658765;5922.170896074553;4530.2978038403935;4545.204589196894;4545.8408955686555;4548.363229147922;4555.453345598533;4374.825006999717;4449.88875278119;4495.258282383403;4528.818847246106;4540.818367265322;4477.507474177838;4481.46222453306;4497.527759585246;4498.775061246941;4505.301678239878;4487.955120448786;4492.68551201416;4527.47933987589;4527.977360113178;4531.660125490602;3982.3827306767207;3984;3987.48162738845;3989.3816458448987;3998.300297447964;5539.113741801292;5683.886322273532;5686.402927692574;5701.315842098975;5715.228444160027;5260.526552610283;5261.421243663194;5274;5276.657017293864;5279.86800329991;6036.366181550918;6310.211223597051;6324.3991820776955;6328.810135695937;6334.87330253397;4274.422952901349;4329.8525890639;4351.0645211279725;4364.301711726109;4375.934360984587;6421.036844473367;6553.606783592952;6554.1151944487365;6555.082288479617;6612.7354905804195;4430.313301438282;4430.446194225722;4432.911341773147;4437.844675436344;4438;4416.293393057095;4490.3040028795585;4492.842750503717;4566.680332376702;4585.656075794329;5260.395054568774;5276.076686579833;5276.604254680914;5279.894402112013;5283.788648454096;6350.745970161234;6362.0774987627465;6369.617822930639;6377.075324077982;6436.774712885121;1590.276424226997;1603.3266028268156;1603.4227678035897;1604.767308740226;1604.9117298548458;1057.1331508163232;1080.702806728156;1081.6863109698256;1084.8535447714457;1085.1210519479248;6037.366076561985;6052;6053.969730151321;6057.121717351048;6067.029275315928;6541.411272985454;6541.869162616721;6546.541742078104;6550.901736473957;6560.376764207393;5818;5927.081302398135;5927.3776253493625;5934.258217722785;5967.731452084667;3484.1463841358523;3518.419460788992;3542.0436482149676;3546.4503002034726;3546.9891081042297;6784.050232967388;6814.522983391214;6821.147356580427;6822.4200942919415;6827.941669041306;6672.0325552794575;6683.398494135551;6684.2647308795995;6684.899726504106;6689.397954184147;6713.362230588086;6897.206821215424;6899.48253880961;6905.827354316182;6907.34380233877;6281.214848143982;6445.774397896051;6568.113304703804;6610.6694665267505;6614.074029635951;6373.458256048288;6480.643564603992;6496.70764815575;6514.250861151028;6515.967420162869;6869.450443964571;6872.209695885037;6878.415334696607;6883.896741548981;6889.104416425833;4329.848455304049;4342.2835232186335;4380.7152535085115;4399.460188933847;4403.163398954189;6553.574017688835;6570.342965703391;6570.474362050929;6571.901421478586;6582.637954912334;6330.49356051524;6364.268109167505;6373.171487706754;6377.904331434939;6379.138816259746;6254.2807577129215;6376.681165941592;6382.680865956777;6383.87232255343;6386.361363863576;6248;6279.717412716347;6280.874382512416;6284.968575157095;6291.465225455888;6388.584741991755;6404.231492220963;6408.58344207625;6413.839654008687;6415.294317625151;6107.511399088151;6217.96891015542;6250.9062364065485;6258.405451482102;6276.372362763687 11:19:51 INFO - PROCESS | 25697 | |5;yui.html;727.9162896266929;736.3630459652401;739.5267029101376;793.5635400529707;847.5338563789918;12949.611511654653;13154.671133221675;13175.472981080757;13265.933670331659;13389.397477113529;12231.449584768685;12231.877681223184;12232.571859984902;12235.938820305886;12334.198277111982;639.9680015999205;653.8234676637305;778.9727359542417;782.9647665855022;798.3852433626105;783.8667426537502;790.9644066017044;792.065362871811;797.7367468735332;797.8882956386111;835.2941764209264;839.2404873589381;839.4291881520563;839.6431516605448;840.4495055738502;660.9966950165242;677.4546490075487;678.5691086160274;679.4190966723454;833.8499070167368;598.8981873081586;610.7648555306195;611.3489134072199;611.5260672978433;611.6146827498692;12774;12839.935800321033;12867.549635762796;12883.549075782303;12893.161944473579;12449.688757781038;12699.238045717286;12749.490020399173;12793.296368699717;13116.344182790823;10468.05787479123;10566.947165264124;10626.468676566217;10970.890291097066;11080.445977701163;3646.252518233782;3708.2027364116575;3719.8698045568544;3833.4441505981754;3834.0223243072837;46378.53621463776;46677.76661116707;46708;46841.29738053932;46989.99999999966;10184.796304074025;10550.525226364833;10589.629362972259;10905.291156074989;11004.724881878017;18057.819421805878;18102.637947240983;18128;18129.818701812812;18177.909110454628;7425.443091768139;7478.925210747823;7535.095788505414;7553.244675532513;7823.608819558999;4344.956550434518;4375.868723938287;4394.560543945579;4535.659825513099;4547.772611369418;3175.984120079385;3214.8874789382257;3216.5014422764507;3217.694319039734;3221.2430078931434;560.5683623609798;589.4724221821446;589.590234786819;593.4303069053757;608.3551435478407;555.2864569028778;571.3001573073035;578.9623674461146;619.665380694429;643.6974621927686;8545.529995850287;8716.389852710376;8793;8810.295176385875;9039.322050846213;550.4468009650276;626.6177631644694;671.0102598666928;686.3102581905154;700.4746440169872;3845.9038524036564;3894.805259737002;3927.2145570885937;3963.048868271652;4045.3122969095325;52646.47353526492;53931.460685392645;53943.73028134834;54760.72619636876;55062.724686377114;45836.3124553132;47808.52191478041;47853;48092.519074809505;48602.51397486051;42820.78589607094;43033.35449968253;44284.55715442869;44709.776451117534;47179.292310614685;8563.400561960603;8666.78333041679;9032.593533291149;9170.67902623405;9203.35576509638;34256.65743342634;34717.305653887284;34844.477332840535;35159;35361.64638353686;40584;44242.33636495391;44244;44306.55693443024;44800.77599611981;9795.461249631338;10369;10534.473276336306;10596.24431863489;10736.51685674131;12273.447694853932;12358.7188187778;12588.307643079352;12713.11008229415;12779.105462617528;11359.602413915472;11469.139814513777;11471.311721296748;11849.585264515701;11915.344656044;11366.545338186379;11576.594819181626;11815.468303926173;11849.940750296193;12003.339816310187;11089.22375433712;11106.444677766242;11113.777724445305;11168.050715689258;11413.258138220988;9689.563969621244;9823.16503097216;9893.851592226267;9983.800323993624;10101.49492525356;9375.980399480173;9544.284178686765;10061.39631622105;10081.36061589554;10106.89893101089 11:19:51 INFO - PROCESS | 25697 | __end_tp_report 11:19:51 INFO - PROCESS | 25697 | __start_cc_report 11:19:51 INFO - PROCESS | 25697 | _x_x_mozilla_cycle_collect,1125 11:19:51 INFO - PROCESS | 25697 | __end_cc_report 11:19:51 INFO - PROCESS | 25697 | __startTimestamp1453231191701__endTimestamp 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | ------- Summary: start ------- 11:19:51 INFO - PROCESS | 25697 | Number of tests: 6 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | [#0] dojo.html Cycles:165 Average:5081.18 Median:5275.10 stddev:645.85 (12.2%) stddev-sans-first:629.01 11:19:51 INFO - PROCESS | 25697 | Values: 3107.8 3135.1 3182.6 3195.9 3210.9 4958.0 5056.8 5139.2 5164.8 5212.7 5075.4 5097.6 5101.6 5107.7 5162.0 4680.9 4707.1 4729.1 4741.7 4819.1 527.8 4595.9 4693.9 4732.4 4761.3 4621.6 4687.5 4729.2 4770.1 4773.9 4693.2 4707.4 4709.8 4716.5 4755.5 4515.8 4642.5 4682.5 4713.3 4758.7 4891.6 4924.4 4981.2 4990.1 5014.4 5403.1 5406.3 5407.5 5410.6 5415.4 5360.9 5429.6 5431.7 5459.8 5473.8 5146.4 5155.3 5161.4 5186.1 5236.8 5561.3 5565.1 5585.6 5588.1 5609.4 5200.0 5395.9 5399.6 5402.8 5403.5 5444.1 5479.3 5491.8 5495.3 5537.1 5418.5 5466.7 5470.2 5470.7 5488.2 5272.4 5361.6 5461.3 5476.5 5514.0 4267.2 4298.7 4316.6 4334.5 4354.7 3829.4 3857.3 3863.1 3895.9 3906.2 5025.6 5105.5 5106.9 5112.8 5119.5 5407.7 5471.2 5490.8 5496.8 5539.3 5116.4 5131.4 5136.2 5146.2 5181.1 4676.5 4709.4 4754.7 4755.0 4763.1 5772.0 5785.7 5800.2 5803.3 5804.1 5564.8 5584.1 5584.8 5585.3 5589.4 5609.4 5679.5 5746.5 5762.5 5773.4 5395.8 5399.7 5410.4 5415.5 5418.6 5478.7 5483.2 5485.3 5487.7 5533.0 5262.8 5336.9 5372.4 5414.2 5417.1 5378.8 5381.9 5387.2 5389.0 5423.0 5284.3 5287.2 5290.6 5291.5 5338.3 5275.1 5380.0 5381.7 5393.8 5419.8 5234.1 5264.0 5265.2 5265.7 5317.8 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | [#1] ext.html Cycles:180 Average:42395.15 Median:33173.33 stddev:70668.40 (213.0%) stddev-sans-first:70796.69 11:19:51 INFO - PROCESS | 25697 | Values: 516.2 524.7 527.2 551.6 568.3 28531.0 28650.6 28853.3 28854.9 28918.5 29324.7 37391.8 37988.2 38008.8 38076.0 8360.8 8499.8 8512.7 8514.5 8524.9 8152.8 8285.2 8293.3 8373.1 8385.3 8370.2 8402.6 8428.7 8436.0 8456.5 8292.6 8546.2 8573.0 8590.1 8597.4 8454.7 8518.4 8521.6 8588.6 8591.0 39977.2 40461.4 40488.2 40530.2 40555.0 3141.6 3231.9 3289.6 3524.8 3668.1 30242.7 30457.0 30756.0 30994.5 31728.8 3562.8 3568.7 3702.4 3774.6 3775.3 260687.0 261732.7 261782.0 263937.0 264647.0 50548.2 51810.5 58542.7 59059.7 59466.4 53757.5 53925.5 54021.0 54086.2 54207.7 12235.3 14892.4 15023.8 15063.2 15074.3 8671.2 10978.5 11278.9 11292.5 11330.9 19274.3 19435.0 19552.9 19553.0 19570.9 6950.9 7312.2 7410.3 7436.9 7495.2 918.8 1017.7 1024.0 1036.7 1038.7 24895.3 25535.6 25585.5 25634.4 25740.2 1007.6 1043.3 1076.6 1135.5 1137.2 13536.3 13764.9 13912.7 14011.4 14014.6 333484.0 333836.0 339123.0 339179.0 340251.0 52021.0 52384.0 52677.2 52687.5 52735.7 1295.5 1306.4 1308.4 1315.5 1335.4 24069.8 24337.6 25743.2 26089.5 27683.5 42412.6 42811.0 42835.6 42846.8 42865.4 187661.0 187697.0 187948.0 188118.0 188793.0 29106.7 32018.0 32558.8 33016.2 33021.2 37631.2 38075.0 38830.2 39015.6 41102.2 34639.5 34822.5 34927.5 35559.5 37057.0 32320.5 32358.5 32537.5 32667.8 32807.0 32279.4 32784.7 32953.7 32960.8 33055.7 28814.4 29408.7 30177.4 32023.8 33291.0 24397.6 24577.3 24654.4 24765.9 24961.4 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | [#2] jquery.html Cycles:180 Average:27515.61 Median:5094.40 stddev:91210.07 (1790.4%) stddev-sans-first:91443.13 11:19:51 INFO - PROCESS | 25697 | Values: 354.5 355.9 358.6 361.3 362.2 13206.3 13554.0 15515.8 16000.2 16974.1 15389.7 15440.9 15980.2 16068.4 16081.8 4952.5 5339.9 5342.6 5345.9 5353.7 3992.2 4126.2 4127.0 5230.6 5738.4 5103.7 5834.0 5885.8 5890.5 5891.1 5231.8 5236.3 5243.2 5262.7 5278.8 4943.4 5071.7 5093.7 5095.1 5118.7 12622.7 12842.1 13143.7 13203.1 13234.3 1971.2 1998.8 2059.1 2065.3 2168.4 9469.6 9512.0 9669.2 9832.8 9862.4 1779.5 1821.3 1821.5 1839.7 1907.2 54676.5 55093.7 55208.0 56223.0 56811.4 9855.5 10020.1 10111.8 10112.4 10182.8 13280.7 13302.3 13379.5 13401.3 13414.7 7371.3 7391.3 7407.7 7455.6 7533.2 6936.4 6975.1 6996.9 6997.2 7134.0 4010.6 4386.0 4438.1 4461.8 4502.5 1749.4 1780.4 1783.8 1787.2 1798.5 971.6 973.0 974.4 989.0 1009.7 15367.7 16033.8 16140.4 16604.1 16660.5 931.1 931.3 938.3 952.6 974.9 8020.5 9314.3 9317.5 9421.3 9514.7 546839.0 547284.0 551882.0 573218.0 573782.0 61811.0 66252.0 69156.3 70405.0 71331.3 1109.1 1120.0 1126.5 1144.7 1146.8 15204.9 15309.0 15448.3 15491.1 15678.8 32388.5 32680.7 32698.7 33351.0 33976.3 37768.2 40678.6 41008.8 41265.0 41788.2 6985.3 7381.5 7399.7 7468.9 7580.0 10627.3 11179.4 11186.1 11187.2 11409.2 7117.6 9196.4 9333.7 9605.3 9679.6 9171.4 9431.3 9694.2 9745.5 9919.2 7672.8 9305.5 9366.4 9737.4 9764.4 7202.2 7416.2 7452.4 7465.0 7478.6 8724.7 10170.0 10188.2 10294.4 10360.1 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | [#3] mootools.html Cycles:180 Average:5452.92 Median:6212.19 stddev:2830.66 (45.6%) stddev-sans-first:2821.37 11:19:51 INFO - PROCESS | 25697 | Values: 1298.3 1412.8 1419.3 1542.4 1742.0 6961.7 7248.5 7368.2 7383.5 7392.7 7439.7 7519.2 7557.6 7578.8 7595.1 1935.8 1966.8 2255.2 2278.0 2293.0 2329.8 2332.5 2344.2 2351.6 2353.7 2256.1 2307.8 2313.9 2315.2 2317.7 2215.9 2240.1 2330.7 2335.6 2338.7 2283.8 2284.7 2305.5 2309.9 2338.3 7720.6 7798.1 7813.2 7818.6 7819.9 4720.8 4857.4 4861.2 4871.0 4878.0 3072.7 3112.8 3172.5 3173.1 3191.5 1001.0 1018.6 1064.6 1081.9 1084.2 10733.5 10753.7 10755.9 10757.4 10760.1 4371.9 4386.5 4439.8 4451.3 4462.8 8631.5 8718.8 8720.1 8720.8 8727.4 4754.7 4789.1 4792.1 4795.4 4799.6 4447.4 4451.7 4452.7 4452.8 4457.7 3327.3 3366.6 3505.3 3521.2 3552.8 1072.6 1086.6 1087.2 1089.4 1097.7 1014.4 1044.2 1044.3 1135.6 1261.0 7324.9 7409.0 7448.2 7459.9 7469.4 1094.1 1097.5 1104.4 1111.1 1131.4 5578.7 5630.8 5665.8 5667.0 5669.1 9425.0 9533.1 9659.0 9678.2 9830.8 9498.9 9610.1 9649.2 9659.8 9676.1 7451.9 7492.6 7499.4 7548.4 7582.5 7213.3 7220.7 7233.0 7248.1 7270.2 8368.3 8472.6 8509.7 8572.7 8729.7 8618.3 8918.6 8973.1 9003.9 9010.9 5975.6 6644.1 6763.7 6781.7 6783.2 6757.7 6790.1 6793.9 7197.4 7381.9 6958.9 6981.4 7016.2 7024.2 7081.8 6937.9 6938.3 6939.2 6968.5 7024.0 6680.4 6706.5 6722.7 6733.6 6741.1 6448.7 6471.3 6490.1 6493.4 6500.3 6659.3 6673.3 6703.4 6712.7 6713.2 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | [#4] prototype.html Cycles:180 Average:5287.41 Median:5936.07 stddev:1607.33 (27.1%) stddev-sans-first:1568.39 11:19:51 INFO - PROCESS | 25697 | Values: 341.4 346.5 350.1 350.6 352.4 5817.9 5903.9 5937.9 5942.0 6023.9 5727.9 5875.9 5890.9 5907.2 5922.2 4530.3 4545.2 4545.8 4548.4 4555.5 4374.8 4449.9 4495.3 4528.8 4540.8 4477.5 4481.5 4497.5 4498.8 4505.3 4488.0 4492.7 4527.5 4528.0 4531.7 3982.4 3984.0 3987.5 3989.4 3998.3 5539.1 5683.9 5686.4 5701.3 5715.2 5260.5 5261.4 5274.0 5276.7 5279.9 6036.4 6310.2 6324.4 6328.8 6334.9 4274.4 4329.9 4351.1 4364.3 4375.9 6421.0 6553.6 6554.1 6555.1 6612.7 4430.3 4430.4 4432.9 4437.8 4438.0 4416.3 4490.3 4492.8 4566.7 4585.7 5260.4 5276.1 5276.6 5279.9 5283.8 6350.7 6362.1 6369.6 6377.1 6436.8 1590.3 1603.3 1603.4 1604.8 1604.9 1057.1 1080.7 1081.7 1084.9 1085.1 6037.4 6052.0 6054.0 6057.1 6067.0 6541.4 6541.9 6546.5 6550.9 6560.4 5818.0 5927.1 5927.4 5934.3 5967.7 3484.1 3518.4 3542.0 3546.5 3547.0 6784.1 6814.5 6821.1 6822.4 6827.9 6672.0 6683.4 6684.3 6684.9 6689.4 6713.4 6897.2 6899.5 6905.8 6907.3 6281.2 6445.8 6568.1 6610.7 6614.1 6373.5 6480.6 6496.7 6514.3 6516.0 6869.5 6872.2 6878.4 6883.9 6889.1 4329.8 4342.3 4380.7 4399.5 4403.2 6553.6 6570.3 6570.5 6571.9 6582.6 6330.5 6364.3 6373.2 6377.9 6379.1 6254.3 6376.7 6382.7 6383.9 6386.4 6248.0 6279.7 6280.9 6285.0 6291.5 6388.6 6404.2 6408.6 6413.8 6415.3 6107.5 6218.0 6250.9 6258.4 6276.4 11:19:51 INFO - PROCESS | 25697 | 11:19:51 INFO - PROCESS | 25697 | [#5] yui.html Cycles:180 Average:13499.22 Median:44264.28 stddev:15188.74 (34.3%) stddev-sans-first:15201.07 11:19:51 INFO - PROCESS | 25697 | Values: 727.9 736.4 739.5 793.6 847.5 12949.6 13154.7 13175.5 13265.9 13389.4 12231.4 12231.9 12232.6 12235.9 12334.2 640.0 653.8 779.0 783.0 798.4 783.9 791.0 792.1 797.7 797.9 835.3 839.2 839.4 839.6 840.4 661.0 677.5 678.6 679.4 833.8 598.9 610.8 611.3 611.5 611.6 12774.0 12839.9 12867.5 12883.5 12893.2 12449.7 12699.2 12749.5 12793.3 13116.3 10468.1 10566.9 10626.5 10970.9 11080.4 3646.3 3708.2 3719.9 3833.4 3834.0 46378.5 46677.8 46708.0 46841.3 46990.0 10184.8 10550.5 10589.6 10905.3 11004.7 18057.8 18102.6 18128.0 18129.8 18177.9 7425.4 7478.9 7535.1 7553.2 7823.6 4345.0 4375.9 4394.6 4535.7 4547.8 3176.0 3214.9 3216.5 3217.7 3221.2 560.6 589.5 589.6 593.4 608.4 555.3 571.3 579.0 619.7 643.7 8545.5 8716.4 8793.0 8810.3 9039.3 550.4 626.6 671.0 686.3 700.5 3845.9 3894.8 3927.2 3963.0 4045.3 52646.5 53931.5 53943.7 54760.7 55062.7 45836.3 47808.5 47853.0 48092.5 48602.5 42820.8 43033.4 44284.6 44709.8 47179.3 8563.4 8666.8 9032.6 9170.7 9203.4 34256.7 34717.3 34844.5 35159.0 35361.6 40584.0 44242.3 44244.0 44306.6 44800.8 9795.5 10369.0 10534.5 10596.2 10736.5 12273.4 12358.7 12588.3 12713.1 12779.1 11359.6 11469.1 11471.3 11849.6 11915.3 11366.5 11576.6 11815.5 11849.9 12003.3 11089.2 11106.4 11113.8 11168.1 11413.3 9689.6 9823.2 9893.9 9983.8 10101.5 9376.0 9544.3 10061.4 10081.4 10106.9 11:19:51 INFO - PROCESS | 25697 | -------- Summary: end -------- 11:19:51 INFO - PROCESS | 25697 | 11:19:52 INFO - TEST-INFO | 25697: exit 0 11:19:52 INFO - TEST-OK | dromaeo_css | took 1112413ms 11:19:52 INFO - TEST-START | kraken 11:19:52 INFO - operating with platform_type : linux_ 11:19:52 INFO - Initialising browser for kraken test... 11:19:52 INFO - TEST-INFO | started process 25903 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHKcTXF/profile http://localhost:59828/getInfo.html) 11:19:56 INFO - PROCESS | 25903 | __metrics Screen width/height:1600/1200 11:19:56 INFO - PROCESS | 25903 | colorDepth:24 11:19:56 INFO - PROCESS | 25903 | Browser inner width/height: 1024/697 11:19:56 INFO - PROCESS | 25903 | __metrics 11:19:56 INFO - PROCESS | 25903 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:19:56 INFO - PROCESS | 25903 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:57 INFO - TEST-INFO | 25903: exit 0 11:19:57 INFO - Browser initialized. 11:19:57 INFO - Running cycle 1/1 for kraken test... 11:19:57 INFO - TEST-INFO | started process 25986 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHKcTXF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:09 INFO - PROCESS | 25986 | RSS: Main: 149319680 11:20:09 INFO - PROCESS | 25986 | 11:20:11 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59828/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:12 INFO - PROCESS | 25986 | RSS: Main: 187432960 11:20:12 INFO - PROCESS | 25986 | 11:20:14 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59828/tests/kraken/driver.html?testName=audio-dft) 11:20:15 INFO - PROCESS | 25986 | RSS: Main: 177340416 11:20:15 INFO - PROCESS | 25986 | 11:20:18 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59828/tests/kraken/driver.html?testName=audio-fft) 11:20:18 INFO - PROCESS | 25986 | RSS: Main: 161779712 11:20:18 INFO - PROCESS | 25986 | 11:20:20 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59828/tests/kraken/driver.html?testName=audio-oscillator) 11:20:21 INFO - PROCESS | 25986 | RSS: Main: 163196928 11:20:21 INFO - PROCESS | 25986 | 11:20:23 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59828/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:24 INFO - PROCESS | 25986 | RSS: Main: 166809600 11:20:24 INFO - PROCESS | 25986 | 11:20:27 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59828/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:27 INFO - PROCESS | 25986 | RSS: Main: 165416960 11:20:27 INFO - PROCESS | 25986 | 11:20:31 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59828/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:31 INFO - PROCESS | 25986 | RSS: Main: 166076416 11:20:31 INFO - PROCESS | 25986 | 11:20:34 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59828/tests/kraken/driver.html?testName=json-parse-financial) 11:20:34 INFO - PROCESS | 25986 | RSS: Main: 165703680 11:20:34 INFO - PROCESS | 25986 | 11:20:36 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59828/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:37 INFO - PROCESS | 25986 | RSS: Main: 178249728 11:20:37 INFO - PROCESS | 25986 | 11:20:38 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:39 INFO - PROCESS | 25986 | RSS: Main: 174997504 11:20:39 INFO - PROCESS | 25986 | 11:20:41 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:42 INFO - PROCESS | 25986 | RSS: Main: 185647104 11:20:42 INFO - PROCESS | 25986 | 11:20:44 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:45 INFO - PROCESS | 25986 | RSS: Main: 193224704 11:20:45 INFO - PROCESS | 25986 | 11:20:47 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:48 INFO - PROCESS | 25986 | RSS: Main: 190586880 11:20:48 INFO - PROCESS | 25986 | 11:20:49 INFO - PROCESS | 25986 | Cycle 1(1): loaded http://localhost:59828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59828/tests/kraken/driver.html?testName=ai-astar) 11:20:50 INFO - PROCESS | 25986 | RSS: Main: 249667584 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | __start_tp_report 11:20:50 INFO - PROCESS | 25986 | _x_x_mozilla_page_load 11:20:50 INFO - PROCESS | 25986 | _x_x_mozilla_page_load_details 11:20:50 INFO - PROCESS | 25986 | |i|pagename|runs| 11:20:50 INFO - PROCESS | 25986 | |0;ai-astar;110;109;105;109;108;109;110;110;104;110 11:20:50 INFO - PROCESS | 25986 | |1;audio-beat-detection;154;127;150;165;127;152;152;135;165;133 11:20:50 INFO - PROCESS | 25986 | |2;audio-dft;163;160;161;159;160;161;160;159;162;163 11:20:50 INFO - PROCESS | 25986 | |3;audio-fft;72;72;96;100;74;75;73;112;92;73 11:20:50 INFO - PROCESS | 25986 | |4;audio-oscillator;97;97;146;95;95;97;155;95;96;134 11:20:50 INFO - PROCESS | 25986 | |5;imaging-gaussian-blur;109;109;109;109;108;109;109;109;110;109 11:20:50 INFO - PROCESS | 25986 | |6;imaging-darkroom;146;145;146;146;145;145;146;145;146;146 11:20:50 INFO - PROCESS | 25986 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 11:20:50 INFO - PROCESS | 25986 | |8;json-parse-financial;57;56;57;56;57;56;58;56;61;58 11:20:50 INFO - PROCESS | 25986 | |9;json-stringify-tinderbox;69;69;68;70;69;70;69;68;69;69 11:20:50 INFO - PROCESS | 25986 | |10;stanford-crypto-aes;80;83;85;81;81;82;81;81;82;82 11:20:50 INFO - PROCESS | 25986 | |11;stanford-crypto-ccm;118;116;115;119;116;114;116;116;124;123 11:20:50 INFO - PROCESS | 25986 | |12;stanford-crypto-pbkdf2;142;144;140;146;142;132;147;141;143;139 11:20:50 INFO - PROCESS | 25986 | |13;stanford-crypto-sha256-iterative;66;67;67;66;68;65;67;66;66;64 11:20:50 INFO - PROCESS | 25986 | __end_tp_report 11:20:50 INFO - PROCESS | 25986 | __start_cc_report 11:20:50 INFO - PROCESS | 25986 | _x_x_mozilla_cycle_collect,933 11:20:50 INFO - PROCESS | 25986 | __end_cc_report 11:20:50 INFO - PROCESS | 25986 | __startTimestamp1453231250073__endTimestamp 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | ------- Summary: start ------- 11:20:50 INFO - PROCESS | 25986 | Number of tests: 14 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:2.17 (2.0%) stddev-sans-first:2.22 11:20:50 INFO - PROCESS | 25986 | Values: 110.0 109.0 105.0 109.0 108.0 109.0 110.0 110.0 104.0 110.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.00 stddev:14.48 (9.5%) stddev-sans-first:15.06 11:20:50 INFO - PROCESS | 25986 | Values: 154.0 127.0 150.0 165.0 127.0 152.0 152.0 135.0 165.0 133.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.48 (0.9%) stddev-sans-first:1.33 11:20:50 INFO - PROCESS | 25986 | Values: 163.0 160.0 161.0 159.0 160.0 161.0 160.0 159.0 162.0 163.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#3] audio-fft Cycles:10 Average:83.90 Median:73.50 stddev:14.75 (20.1%) stddev-sans-first:15.01 11:20:50 INFO - PROCESS | 25986 | Values: 72.0 72.0 96.0 100.0 74.0 75.0 73.0 112.0 92.0 73.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:95.50 stddev:24.20 (25.3%) stddev-sans-first:25.15 11:20:50 INFO - PROCESS | 25986 | Values: 97.0 97.0 146.0 95.0 95.0 97.0 155.0 95.0 96.0 134.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:20:50 INFO - PROCESS | 25986 | Values: 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 110.0 109.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:20:50 INFO - PROCESS | 25986 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 11:20:50 INFO - PROCESS | 25986 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.55 (2.7%) stddev-sans-first:1.64 11:20:50 INFO - PROCESS | 25986 | Values: 57.0 56.0 57.0 56.0 57.0 56.0 58.0 56.0 61.0 58.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:20:50 INFO - PROCESS | 25986 | Values: 69.0 69.0 68.0 70.0 69.0 70.0 69.0 68.0 69.0 69.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.40 (1.7%) stddev-sans-first:1.32 11:20:50 INFO - PROCESS | 25986 | Values: 80.0 83.0 85.0 81.0 81.0 82.0 81.0 81.0 82.0 82.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:117.00 stddev:3.37 (2.9%) stddev-sans-first:3.57 11:20:50 INFO - PROCESS | 25986 | Values: 118.0 116.0 115.0 119.0 116.0 114.0 116.0 116.0 124.0 123.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:142.50 stddev:4.20 (2.9%) stddev-sans-first:4.45 11:20:50 INFO - PROCESS | 25986 | Values: 142.0 144.0 140.0 146.0 142.0 132.0 147.0 141.0 143.0 139.0 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - PROCESS | 25986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.14 (1.7%) stddev-sans-first:1.20 11:20:50 INFO - PROCESS | 25986 | Values: 66.0 67.0 67.0 66.0 68.0 65.0 67.0 66.0 66.0 64.0 11:20:50 INFO - PROCESS | 25986 | -------- Summary: end -------- 11:20:50 INFO - PROCESS | 25986 | 11:20:50 INFO - TEST-INFO | 25986: exit 0 11:20:50 INFO - TEST-OK | kraken | took 58618ms 11:20:50 INFO - TEST-START | v8_7 11:20:50 INFO - operating with platform_type : linux_ 11:20:51 INFO - Initialising browser for v8_7 test... 11:20:51 INFO - TEST-INFO | started process 26234 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKJuGgh/profile http://localhost:59828/getInfo.html) 11:20:55 INFO - PROCESS | 26234 | __metrics Screen width/height:1600/1200 11:20:55 INFO - PROCESS | 26234 | colorDepth:24 11:20:55 INFO - PROCESS | 26234 | Browser inner width/height: 1024/697 11:20:55 INFO - PROCESS | 26234 | __metrics 11:20:55 INFO - PROCESS | 26234 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:20:55 INFO - PROCESS | 26234 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:56 INFO - TEST-INFO | 26234: exit 0 11:20:56 INFO - Browser initialized. 11:20:56 INFO - Running cycle 1/1 for v8_7 test... 11:20:56 INFO - TEST-INFO | started process 26322 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKJuGgh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:07 INFO - PROCESS | 26322 | RSS: Main: 149188608 11:21:07 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | Cycle 1(1): loaded http://localhost:59828/tests/v8_7/run.html (next: http://localhost:59828/tests/v8_7/run.html) 11:21:30 INFO - PROCESS | 26322 | RSS: Main: 558362624 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | __start_tp_report 11:21:30 INFO - PROCESS | 26322 | _x_x_mozilla_page_load 11:21:30 INFO - PROCESS | 26322 | _x_x_mozilla_page_load_details 11:21:30 INFO - PROCESS | 26322 | |i|pagename|runs| 11:21:30 INFO - PROCESS | 26322 | |0;Richards;167.47613465081227 11:21:30 INFO - PROCESS | 26322 | |1;DeltaBlue;188.35938971557732 11:21:30 INFO - PROCESS | 26322 | |2;Encrypt;280.2690582959641 11:21:30 INFO - PROCESS | 26322 | |3;Decrypt;5218.75 11:21:30 INFO - PROCESS | 26322 | |4;RayTrace;1104.9723756906078 11:21:30 INFO - PROCESS | 26322 | |5;Earley;784.3137254901961 11:21:30 INFO - PROCESS | 26322 | |6;Boyer;12358.024691358025 11:21:30 INFO - PROCESS | 26322 | |7;RegExp;42500 11:21:30 INFO - PROCESS | 26322 | |8;Splay;584.5974329054842 11:21:30 INFO - PROCESS | 26322 | |9;NavierStokes;4835.748792270531 11:21:30 INFO - PROCESS | 26322 | __end_tp_report 11:21:30 INFO - PROCESS | 26322 | __startTimestamp1453231290634__endTimestamp 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | ------- Summary: start ------- 11:21:30 INFO - PROCESS | 26322 | Number of tests: 10 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 167.5 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#1] DeltaBlue Cycles:1 Average:188.36 Median:188.36 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 188.4 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 280.3 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 5218.8 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 1105.0 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 784.3 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 12358.0 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#7] RegExp Cycles:1 Average:42500.00 Median:42500.00 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 42500.0 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#8] Splay Cycles:1 Average:584.60 Median:584.60 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 584.6 11:21:30 INFO - PROCESS | 26322 | 11:21:30 INFO - PROCESS | 26322 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:21:30 INFO - PROCESS | 26322 | Values: 4835.7 11:21:30 INFO - PROCESS | 26322 | -------- Summary: end -------- 11:21:30 INFO - PROCESS | 26322 | 11:21:31 INFO - TEST-INFO | 26322: exit 0 11:21:31 INFO - TEST-OK | v8_7 | took 40510ms 11:21:31 INFO - SUITE-END | took 1211s 11:21:31 INFO - Completed test suite (00:20:11) 11:21:31 INFO - Working with test: dromaeo_css 11:21:31 INFO - Generating results file: dromaeo_css 11:21:31 INFO - Working with test: kraken 11:21:31 INFO - Generating results file: kraken 11:21:31 INFO - javascript benchmark 11:21:31 INFO - Working with test: v8_7 11:21:31 INFO - Generating results file: v8_7 11:21:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:21:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:21:31 INFO - process_Request line: dromaeo_css 6725.85 graph.html#tests=[[72,64,35]] 11:21:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:21:31 INFO - process_Request line: kraken 1493.80 graph.html#tests=[[232,64,35]] 11:21:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:21:31 INFO - process_Request line: v8_7 20080.70 graph.html#tests=[[230,64,35]] 11:21:31 INFO - RETURN: dromaeo_css: 6725.85 11:21:31 INFO - RETURN: kraken: 1493.80 11:21:31 INFO - RETURN: v8_7: 20080.70 11:21:31 INFO - javascript benchmark 11:21:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3107.766917481189, 3135.0594821553527, 3182.6339970903337, 3195.888143914965, 3210.871565137394, 4958.0, 5056.797728090881, 5139.229115632652, 5164.767585458654, 5212.661177023496, 5075.416327122382, 5097.59219262459, 5101.617378696594, 5107.668001579904, 5162.045021670993, 4680.882977925562, 4707.05858828234, 4729.077829823186, 4741.7154970701695, 4819.108464933998, 527.7755799009032, 4595.862124136282, 4693.9061218775605, 4732.432108147027, 4761.262004389308, 4621.560951709599, 4687.460941991663, 4729.172394830891, 4770.1413745525615, 4773.928391074137, 4693.178693728584, 4707.38803955487, 4709.835155769566, 4716.481187069454, 4755.476897541268, 4515.819367225307, 4642.489326174118, 4682.531746825291, 4713.316569097496, 4758.738269395217, 4891.559759621616, 4924.4090709115135, 4981.227909674007, 4990.126727822617, 5014.448410674823, 5403.13549832025, 5406.270153529263, 5407.486288802596, 5410.594205434608, 5415.431379705114, 5360.919586206171, 5429.592780541475, 5431.665261782355, 5459.754311056012, 5473.8357849264585, 5146.356705411824, 5155.329807125087, 5161.406438259611, 5186.118359878829, 5236.764345604457, 5561.277033985556, 5565.0817615093865, 5585.58108141891, 5588.133839254922, 5609.411011843779, 5200.0, 5395.919061214085, 5399.568034557226, 5402.756875940592, 5403.459654034644, 5444.074507333763, 5479.2602998594675, 5491.752871120809, 5495.2856128703015, 5537.086380747131, 5418.512333889968, 5466.671999680032, 5470.152126420411, 5470.7264636768, 5488.204210389471, 5272.446393128743, 5361.5710743141235, 5461.290032295856, 5476.534494567926, 5513.972430137824, 4267.1892340455215, 4298.742075475481, 4316.6330861877095, 4334.45819272591, 4354.695171337976, 3829.387298032357, 3857.3442514772555, 3863.0535518798074, 3895.902602434962, 3906.2382835347403, 5025.623078269145, 5105.514976077341, 5106.897862042739, 5112.846614601568, 5119.48805119485, 5407.729613519308, 5471.23402723619, 5490.752916118784, 5496.835094947078, 5539.307586551681, 5116.386033675983, 5131.358580177478, 5136.203888397305, 5146.202338637517, 5181.093308670967, 4676.532346765296, 4709.434867815884, 4754.667173297836, 4755.001449695603, 4763.142634325785, 5771.971140144273, 5785.681787501728, 5800.24596802413, 5803.332616749043, 5804.1293805929445, 5564.777408903598, 5584.134459158837, 5584.832455026356, 5585.301837270341, 5589.413111623384, 5609.382967873449, 5679.460451257124, 5746.540276777764, 5762.538996880324, 5773.364929857797, 5395.78416863321, 5399.676019438846, 5410.350757908918, 5415.48552887475, 5418.620696551204, 5478.726063696879, 5483.2323474712775, 5485.341758988947, 5487.6981766003255, 5533.004059269209, 5262.815801447084, 5336.946630533645, 5372.435894231049, 5414.242006119068, 5417.133258678593, 5378.784848606168, 5381.8923621526565, 5387.191921211849, 5389.0, 5423.0, 5284.339457567804, 5287.206918962186, 5290.629655924048, 5291.523762861361, 5338.332708411449, 5275.1032324505695, 5380.0, 5381.67709937405, 5393.784248630011, 5419.83740487786, 5234.13636749932, 5264.0, 5265.21021846726, 5265.657732247391, 5317.787288508571], "unit": "score", "name": "dojo.html", "value": 5043.635968716644}, {"lowerIsBetter": false, "replicates": [516.1586613819474, 524.7350088205458, 527.2328761651797, 551.5615086006625, 568.2924758675448, 28531.0, 28650.570241446396, 28853.27866803331, 28854.85572572137, 28918.529776426807, 29324.706752932463, 37391.81304093482, 37988.24023519528, 38008.80995595025, 38076.0, 8360.790980225482, 8499.787505312386, 8512.659493620247, 8514.48913065218, 8524.914750852506, 8152.836943261132, 8285.212904774067, 8293.253607175353, 8373.12082231366, 8385.329173666123, 8370.204830541088, 8402.621882015324, 8428.747137585882, 8436.0, 8456.492610443393, 8292.626831792553, 8546.2308392245, 8572.957135214347, 8590.098039705867, 8597.398182127254, 8454.661813527451, 8518.446300990478, 8521.616527256288, 8588.570571471402, 8590.957045214796, 39977.20330552083, 40461.39307910384, 40488.190236195405, 40530.189396212205, 40554.97225138731, 3141.6387115481784, 3231.87072517099, 3289.5723555937816, 3524.7708898921487, 3668.137987572918, 30242.69757302421, 30457.0, 30756.0, 30994.535081973787, 31728.841355793305, 3562.7684200526883, 3568.678818906311, 3702.4446333049987, 3774.6225377462033, 3775.339315619756, 260687.0, 261732.691336544, 261782.0, 263937.0, 264647.0, 50548.24177637338, 51810.48189518132, 58542.707286463294, 59059.70470147622, 59466.405335946954, 53757.46242537525, 53925.46074539205, 54021.0, 54086.18870716942, 54207.72896135573, 12235.265884046985, 14892.404303827941, 15023.849761502464, 15063.17152556598, 15074.321655525528, 8671.21959023691, 10978.505967231495, 11278.943605282086, 11292.54829806815, 11330.886691133148, 19274.32539861098, 19434.959329270223, 19552.90223548873, 19553.0, 19570.90214548918, 6950.930490695129, 7312.1956584775635, 7410.258974102547, 7436.888446673304, 7495.175530691619, 918.820829938169, 1017.6946915925192, 1024.032289486443, 1036.657902892044, 1038.6624347087077, 24895.253142405756, 25535.61696574553, 25585.48829023409, 25634.35914102125, 25740.227793166236, 1007.5919252702668, 1043.3479075577764, 1076.5908954597203, 1135.517405102828, 1137.2494153858413, 13536.255505947267, 13764.862351376358, 13912.721745565032, 14011.369488373048, 14014.579562613138, 333484.0, 333836.0, 339123.0, 339179.0, 340251.0, 52021.0, 52384.0, 52677.209841852404, 52687.473125269025, 52735.736321318145, 1295.5400832704443, 1306.4186437035428, 1308.3915979069777, 1315.500109958229, 1335.3857225676104, 24069.796510174772, 24337.634935475628, 25743.227703168934, 26089.478210436064, 27683.508484236514, 42412.575874240865, 42811.0, 42835.57164428316, 42846.78576607097, 42865.35701964411, 187661.0, 187697.0, 187948.0, 188118.0, 188793.0, 29106.708932911246, 32018.0, 32558.83720581382, 33016.174595635304, 33021.17447063747, 37631.2473750518, 38075.0, 38830.2233955325, 39015.6098439012, 41102.1779564413, 34639.480407794406, 34822.47766283457, 34927.476087858195, 35559.46660800038, 37057.0, 32320.515192272604, 32358.514622280214, 32537.511937320487, 32667.836660816545, 32807.0, 32279.35441291208, 32784.67215327816, 32953.681852725626, 32960.83519582387, 33055.66944330526, 28814.423711526073, 29408.676609552193, 30177.396452071276, 32023.839880800446, 33291.0, 24397.634035489125, 24577.262682119566, 24654.383640409134, 24765.87617061903, 24961.375965601004], "unit": "score", "name": "ext.html", "value": 17367.819668504533}, {"lowerIsBetter": false, "replicates": [354.4842254519674, 355.89501097176344, 358.60016082068483, 361.3207170519423, 362.21760996248105, 13206.339683015834, 13554.0, 15515.767263491043, 16000.199990000498, 16974.066426346562, 15389.69220615587, 15440.922795386008, 15980.200989950514, 16068.357265709357, 16081.83918160818, 4952.479989601094, 5339.866503337409, 5342.572594192456, 5345.893082138355, 5353.705546194958, 3992.2215168042244, 4126.154138401621, 4126.958730412703, 5230.607704422184, 5738.42615738427, 5103.719295438749, 5833.970830145843, 5885.7939972100985, 5890.469857712805, 5891.057430811071, 5231.790728370861, 5236.266922630834, 5243.187305967543, 5262.710550919698, 5278.788848446057, 4943.431505376856, 5071.695698258116, 5093.668911520739, 5095.133827249339, 5118.718470484122, 12622.74754504914, 12842.101052926299, 13143.671408214872, 13203.075784695075, 13234.27211503367, 1971.2213675598202, 1998.7901270366547, 2059.1351632314313, 2065.2874758208395, 2168.4253672776726, 9469.621215151386, 9512.0, 9669.17811985982, 9832.754181145528, 9862.408255504693, 1779.5373202967191, 1821.289697018164, 1821.4535639308156, 1839.7424360589393, 1907.2466375781628, 54676.45323546753, 55093.724531377484, 55208.0, 56223.0, 56811.43188568144, 9855.45794981283, 10020.148287395506, 10111.797764044824, 10112.443815590066, 10182.847257291147, 13280.73438531224, 13302.334883255991, 13379.464821407035, 13401.262930538915, 13414.731705365837, 7371.299726525972, 7391.260873912565, 7407.703691852374, 7455.589942553212, 7533.20901305366, 6936.445084393236, 6975.058367120475, 6996.860062798817, 6997.230304666483, 7133.96433017842, 4010.5588385277597, 4385.978070109629, 4438.090191510732, 4461.7992190351515, 4502.50472448037, 1749.3877143000102, 1780.3946658136297, 1783.8394544490798, 1787.1868299923503, 1798.5323815807722, 971.5725080964353, 973.0339078584315, 974.4153507895206, 988.9764094162507, 1009.7324209084599, 15367.692646147014, 16033.759493607606, 16140.354385824436, 16604.086775227235, 16660.50018499447, 931.1340453378423, 931.3015238571072, 938.2681508423441, 952.5999080386255, 974.8732664753537, 8020.478668886503, 9314.254859611216, 9317.534123293808, 9421.340506164503, 9514.666986655433, 546839.0, 547284.0, 551882.0, 573218.0, 573782.0, 61811.0, 66252.0, 69156.30843691599, 70405.0, 71331.2866871335, 1109.0794640448407, 1119.9832002519968, 1126.4705588373452, 1144.66804626659, 1146.7591805720892, 15204.923975380052, 15309.0, 15448.30482628262, 15491.07053576789, 15678.76481852796, 32388.514172287905, 32680.67319326776, 32698.673013269563, 33351.0, 33976.3204735899, 37768.244635107694, 40678.59321406748, 41008.79495602622, 41265.0, 41788.16423671449, 6985.26654701249, 7381.483296169216, 7399.704011839682, 7468.887966680395, 7579.962100189464, 10627.309224900357, 11179.385133817717, 11186.105111591216, 11187.16096292765, 11409.201355905006, 7117.6085315308155, 9196.448213107235, 9333.719988400358, 9605.327627066039, 9679.564419601276, 9171.44971301724, 9431.339806213498, 9694.246923130448, 9745.463999480096, 9919.15687166599, 7672.769816905502, 9305.488198148896, 9366.438013718926, 9737.367071140354, 9764.365316254421, 7202.207757146814, 7416.221296763762, 7452.403807695263, 7464.962675186589, 7478.551286922802, 8724.738257852274, 10170.0, 10188.235882309005, 10294.433806140734, 10360.067593916583], "unit": "score", "name": "jquery.html", "value": 7953.033272755678}, {"lowerIsBetter": false, "replicates": [1298.2599918046706, 1412.8163338765962, 1419.2761691537316, 1542.4293011585708, 1742.033171589768, 6961.651917404135, 7248.4563657725685, 7368.226336234685, 7383.4831561790625, 7392.741254056109, 7439.702411903518, 7519.172890981988, 7557.58433286169, 7578.810529736746, 7595.088589369269, 1935.8451323894126, 1966.7541557305337, 2255.1881322723807, 2277.999999999996, 2293.025464177726, 2329.801966832821, 2332.5334933013382, 2344.2264052862515, 2351.623740201568, 2353.6940197774265, 2256.0524579676494, 2307.8038366738765, 2313.8843057847125, 2315.2475445480286, 2317.6639387288833, 2215.8920539730134, 2240.0815665577115, 2330.7203135623663, 2335.6262997920253, 2338.6608941703444, 2283.794458498743, 2284.657301404786, 2305.5388922215457, 2309.8960546775434, 2338.275134708246, 7720.575368354738, 7798.064232292161, 7813.17961614028, 7818.609069546556, 7819.882701759479, 4720.811167553294, 4857.441394239672, 4861.246506791453, 4870.975645121787, 4877.951220487786, 3072.738817200541, 3112.750979921601, 3172.5406313096005, 3173.0639461358955, 3191.48936170214, 1000.9551858632484, 1018.6180182431589, 1064.5741703318656, 1081.859358283418, 1084.2301965604431, 10733.516991735312, 10753.731156721145, 10755.892441075646, 10757.408342541157, 10760.139188864872, 4371.912561748811, 4386.539413361615, 4439.778011099432, 4451.310046942729, 4462.799174037176, 8631.482111073356, 8718.82562348762, 8720.084391138838, 8720.78198045054, 8727.432716873383, 4754.667173297905, 4789.137955168034, 4792.113459010095, 4795.376601041842, 4799.616030717534, 4447.421835161408, 4451.666125040635, 4452.710573812692, 4452.8218871245435, 4457.7102488338805, 3327.334533093391, 3366.6296707362662, 3505.298940211968, 3521.2253304273017, 3552.8223588820974, 1072.5548897207727, 1086.5653738504661, 1087.244365166202, 1089.4008295437477, 1097.6871591596516, 1014.4369874719454, 1044.2064031336088, 1044.3264094658903, 1135.5911871726173, 1261.0164072023836, 7324.926750732531, 7409.0, 7448.180700122982, 7459.925400745923, 7469.402447804163, 1094.1083017341, 1097.4622435006788, 1104.447776111944, 1111.111111111124, 1131.4173200801595, 5578.665280083208, 5630.802921897796, 5665.773369065191, 5667.036603777367, 5669.064604340238, 9424.95287523558, 9533.094356036165, 9658.951705241428, 9678.17735492477, 9830.75423114428, 9498.90501094994, 9610.087041731025, 9649.179819715402, 9659.758506037264, 9676.12914837668, 7451.85096298071, 7492.550446973199, 7499.400047996147, 7548.433867459962, 7582.507137036075, 7213.314735100157, 7220.74727384539, 7233.0, 7248.0939882514685, 7270.200277969313, 8368.288695460955, 8472.61873215719, 8509.74470765878, 8572.657093716181, 8729.694460693845, 8618.267447267053, 8918.643254269757, 8973.147550982647, 9003.90996090057, 9010.90989090127, 5975.641461512323, 6644.069830223869, 6763.695633696397, 6781.694823732845, 6783.219929708147, 6757.662116894234, 6790.117284753148, 6793.932060679527, 7197.424206063607, 7381.926180738339, 6958.8956165658565, 6981.441484681315, 7016.228214896255, 7024.192217894803, 7081.787546373617, 6937.89593156093, 6938.340857618518, 6939.201991771011, 6968.477364197604, 7024.0, 6680.432163266177, 6706.497012724163, 6722.731090756315, 6733.595984240961, 6741.1236539249585, 6448.742050317935, 6471.320511346429, 6490.091387205701, 6493.448056915215, 6500.284968653539, 6659.300773418721, 6673.299303573249, 6703.363180497845, 6712.731490740511, 6713.227978782503], "unit": "score", "name": "mootools.html", "value": 4472.206245874525}, {"lowerIsBetter": false, "replicates": [341.4485605746719, 346.5183395080838, 350.11421104605347, 350.6458476938292, 352.4273056283539, 5817.941820581793, 5903.911441328378, 5937.88124237515, 5941.970290148549, 6023.939760602393, 5727.885442291152, 5875.853103672411, 5890.852728681774, 5907.202527658765, 5922.170896074553, 4530.2978038403935, 4545.204589196894, 4545.8408955686555, 4548.363229147922, 4555.453345598533, 4374.825006999717, 4449.88875278119, 4495.258282383403, 4528.818847246106, 4540.818367265322, 4477.507474177838, 4481.46222453306, 4497.527759585246, 4498.775061246941, 4505.301678239878, 4487.955120448786, 4492.68551201416, 4527.47933987589, 4527.977360113178, 4531.660125490602, 3982.3827306767207, 3984.0, 3987.48162738845, 3989.3816458448987, 3998.300297447964, 5539.113741801292, 5683.886322273532, 5686.402927692574, 5701.315842098975, 5715.228444160027, 5260.526552610283, 5261.421243663194, 5274.0, 5276.657017293864, 5279.86800329991, 6036.366181550918, 6310.211223597051, 6324.3991820776955, 6328.810135695937, 6334.87330253397, 4274.422952901349, 4329.8525890639, 4351.0645211279725, 4364.301711726109, 4375.934360984587, 6421.036844473367, 6553.606783592952, 6554.1151944487365, 6555.082288479617, 6612.7354905804195, 4430.313301438282, 4430.446194225722, 4432.911341773147, 4437.844675436344, 4438.0, 4416.293393057095, 4490.3040028795585, 4492.842750503717, 4566.680332376702, 4585.656075794329, 5260.395054568774, 5276.076686579833, 5276.604254680914, 5279.894402112013, 5283.788648454096, 6350.745970161234, 6362.0774987627465, 6369.617822930639, 6377.075324077982, 6436.774712885121, 1590.276424226997, 1603.3266028268156, 1603.4227678035897, 1604.767308740226, 1604.9117298548458, 1057.1331508163232, 1080.702806728156, 1081.6863109698256, 1084.8535447714457, 1085.1210519479248, 6037.366076561985, 6052.0, 6053.969730151321, 6057.121717351048, 6067.029275315928, 6541.411272985454, 6541.869162616721, 6546.541742078104, 6550.901736473957, 6560.376764207393, 5818.0, 5927.081302398135, 5927.3776253493625, 5934.258217722785, 5967.731452084667, 3484.1463841358523, 3518.419460788992, 3542.0436482149676, 3546.4503002034726, 3546.9891081042297, 6784.050232967388, 6814.522983391214, 6821.147356580427, 6822.4200942919415, 6827.941669041306, 6672.0325552794575, 6683.398494135551, 6684.2647308795995, 6684.899726504106, 6689.397954184147, 6713.362230588086, 6897.206821215424, 6899.48253880961, 6905.827354316182, 6907.34380233877, 6281.214848143982, 6445.774397896051, 6568.113304703804, 6610.6694665267505, 6614.074029635951, 6373.458256048288, 6480.643564603992, 6496.70764815575, 6514.250861151028, 6515.967420162869, 6869.450443964571, 6872.209695885037, 6878.415334696607, 6883.896741548981, 6889.104416425833, 4329.848455304049, 4342.2835232186335, 4380.7152535085115, 4399.460188933847, 4403.163398954189, 6553.574017688835, 6570.342965703391, 6570.474362050929, 6571.901421478586, 6582.637954912334, 6330.49356051524, 6364.268109167505, 6373.171487706754, 6377.904331434939, 6379.138816259746, 6254.2807577129215, 6376.681165941592, 6382.680865956777, 6383.87232255343, 6386.361363863576, 6248.0, 6279.717412716347, 6280.874382512416, 6284.968575157095, 6291.465225455888, 6388.584741991755, 6404.231492220963, 6408.58344207625, 6413.839654008687, 6415.294317625151, 6107.511399088151, 6217.96891015542, 6250.9062364065485, 6258.405451482102, 6276.372362763687], "unit": "score", "name": "prototype.html", "value": 4770.586979402897}, {"lowerIsBetter": false, "replicates": [727.9162896266929, 736.3630459652401, 739.5267029101376, 793.5635400529707, 847.5338563789918, 12949.611511654653, 13154.671133221675, 13175.472981080757, 13265.933670331659, 13389.397477113529, 12231.449584768685, 12231.877681223184, 12232.571859984902, 12235.938820305886, 12334.198277111982, 639.9680015999205, 653.8234676637305, 778.9727359542417, 782.9647665855022, 798.3852433626105, 783.8667426537502, 790.9644066017044, 792.065362871811, 797.7367468735332, 797.8882956386111, 835.2941764209264, 839.2404873589381, 839.4291881520563, 839.6431516605448, 840.4495055738502, 660.9966950165242, 677.4546490075487, 678.5691086160274, 679.4190966723454, 833.8499070167368, 598.8981873081586, 610.7648555306195, 611.3489134072199, 611.5260672978433, 611.6146827498692, 12774.0, 12839.935800321033, 12867.549635762796, 12883.549075782303, 12893.161944473579, 12449.688757781038, 12699.238045717286, 12749.490020399173, 12793.296368699717, 13116.344182790823, 10468.05787479123, 10566.947165264124, 10626.468676566217, 10970.890291097066, 11080.445977701163, 3646.252518233782, 3708.2027364116575, 3719.8698045568544, 3833.4441505981754, 3834.0223243072837, 46378.53621463776, 46677.76661116707, 46708.0, 46841.29738053932, 46989.99999999966, 10184.796304074025, 10550.525226364833, 10589.629362972259, 10905.291156074989, 11004.724881878017, 18057.819421805878, 18102.637947240983, 18128.0, 18129.818701812812, 18177.909110454628, 7425.443091768139, 7478.925210747823, 7535.095788505414, 7553.244675532513, 7823.608819558999, 4344.956550434518, 4375.868723938287, 4394.560543945579, 4535.659825513099, 4547.772611369418, 3175.984120079385, 3214.8874789382257, 3216.5014422764507, 3217.694319039734, 3221.2430078931434, 560.5683623609798, 589.4724221821446, 589.590234786819, 593.4303069053757, 608.3551435478407, 555.2864569028778, 571.3001573073035, 578.9623674461146, 619.665380694429, 643.6974621927686, 8545.529995850287, 8716.389852710376, 8793.0, 8810.295176385875, 9039.322050846213, 550.4468009650276, 626.6177631644694, 671.0102598666928, 686.3102581905154, 700.4746440169872, 3845.9038524036564, 3894.805259737002, 3927.2145570885937, 3963.048868271652, 4045.3122969095325, 52646.47353526492, 53931.460685392645, 53943.73028134834, 54760.72619636876, 55062.724686377114, 45836.3124553132, 47808.52191478041, 47853.0, 48092.519074809505, 48602.51397486051, 42820.78589607094, 43033.35449968253, 44284.55715442869, 44709.776451117534, 47179.292310614685, 8563.400561960603, 8666.78333041679, 9032.593533291149, 9170.67902623405, 9203.35576509638, 34256.65743342634, 34717.305653887284, 34844.477332840535, 35159.0, 35361.64638353686, 40584.0, 44242.33636495391, 44244.0, 44306.55693443024, 44800.77599611981, 9795.461249631338, 10369.0, 10534.473276336306, 10596.24431863489, 10736.51685674131, 12273.447694853932, 12358.7188187778, 12588.307643079352, 12713.11008229415, 12779.105462617528, 11359.602413915472, 11469.139814513777, 11471.311721296748, 11849.585264515701, 11915.344656044, 11366.545338186379, 11576.594819181626, 11815.468303926173, 11849.940750296193, 12003.339816310187, 11089.22375433712, 11106.444677766242, 11113.777724445305, 11168.050715689258, 11413.258138220988, 9689.563969621244, 9823.16503097216, 9893.851592226267, 9983.800323993624, 10101.49492525356, 9375.980399480173, 9544.284178686765, 10061.39631622105, 10081.36061589554, 10106.89893101089], "unit": "score", "name": "yui.html", "value": 6227.7407284379215}], "name": "dromaeo_css", "value": 6725.847679880694}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 105.0, 109.0, 108.0, 109.0, 110.0, 110.0, 104.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 150.0, 165.0, 127.0, 152.0, 152.0, 135.0, 165.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 159.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 96.0, 100.0, 74.0, 75.0, 73.0, 112.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 146.0, 95.0, 95.0, 97.0, 155.0, 95.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 56.0, 57.0, 56.0, 58.0, 56.0, 61.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 70.0, 69.0, 70.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 85.0, 81.0, 81.0, 82.0, 81.0, 81.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 115.0, 119.0, 116.0, 114.0, 116.0, 116.0, 124.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [142.0, 144.0, 140.0, 146.0, 142.0, 132.0, 147.0, 141.0, 143.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 68.0, 65.0, 67.0, 66.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1493.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [188.35938971557732], "unit": "score", "name": "DeltaBlue", "value": 351.0204619999999}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [42500.0], "unit": "score", "name": "RegExp", "value": 21.434941176470574}, {"lowerIsBetter": false, "replicates": [584.5974329054842], "unit": "score", "name": "Splay", "value": 139.39678043912178}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20080.69825224771}]} 11:21:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20080.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6725.85"}}} 11:21:31 INFO - Return code: 0 11:21:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:21:31 INFO - # TBPL SUCCESS # 11:21:31 INFO - Running post-action listener: _resource_record_post_action 11:21:31 INFO - Running post-run listener: _resource_record_post_run 11:21:32 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 73728; Write bytes: 541450240; Read time: 172; Write time: 490040 11:21:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237207552; Read time: 0; Write time: 277752 11:21:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 73728; Write bytes: 303980544; Read time: 172; Write time: 212264 11:21:33 INFO - Running post-run listener: _upload_blobber_files 11:21:33 INFO - Blob upload gear active. 11:21:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:21:33 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 11:21:33 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'] 11:21:33 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 11:21:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:21:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:21:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:21:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:34 INFO - (blobuploader) - INFO - Done attempting. 11:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:21:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:35 INFO - (blobuploader) - INFO - Done attempting. 11:21:35 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:35 INFO - Return code: 0 11:21:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:21:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a73b473c88ed69b63ce6e6353baedd9f13a8d04a64569bbff9bc6c41b04f1ac300a7113581d285c4166d81dbac84a79c7427d56b12084f1adebc748d2d771d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f836a683889ef6db96160e3e0692f6e55391429cf0fd29112d78fb9ee6ee26d52103884f105f2410a8c500858a2e8d582c51d7aeec1784eaa4043d995e12d3"} 11:21:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:21:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:21:35 INFO - Contents: 11:21:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a73b473c88ed69b63ce6e6353baedd9f13a8d04a64569bbff9bc6c41b04f1ac300a7113581d285c4166d81dbac84a79c7427d56b12084f1adebc748d2d771d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f836a683889ef6db96160e3e0692f6e55391429cf0fd29112d78fb9ee6ee26d52103884f105f2410a8c500858a2e8d582c51d7aeec1784eaa4043d995e12d3"} 11:21:35 INFO - Running post-run listener: copy_logs_to_upload_dir 11:21:35 INFO - Copying logs to upload dir... 11:21:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:21:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.205340 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-19 11:21:34.837000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 11:21:34.840266) ========= 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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 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/a73b473c88ed69b63ce6e6353baedd9f13a8d04a64569bbff9bc6c41b04f1ac300a7113581d285c4166d81dbac84a79c7427d56b12084f1adebc748d2d771d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f836a683889ef6db96160e3e0692f6e55391429cf0fd29112d78fb9ee6ee26d52103884f105f2410a8c500858a2e8d582c51d7aeec1784eaa4043d995e12d3"} build_url:https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/fjfdoeswQwKXiQuoAAtC1Q/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/a73b473c88ed69b63ce6e6353baedd9f13a8d04a64569bbff9bc6c41b04f1ac300a7113581d285c4166d81dbac84a79c7427d56b12084f1adebc748d2d771d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f836a683889ef6db96160e3e0692f6e55391429cf0fd29112d78fb9ee6ee26d52103884f105f2410a8c500858a2e8d582c51d7aeec1784eaa4043d995e12d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 11:21:34.864911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:21:34.865217) ========= 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=574dc5aafe09851ec43d388c000001b6-1453228985.632147-1028353245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 11:21:34.948073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 11:21:34.948390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 11:21:34.948692) ========= ========= Total master_lag: 0.21 =========