builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1450750404.62 results: success (0) buildid: 20151221143014 builduid: f9c88fd90b224fff99e4cd5dcbee64c6 revision: 9c9cff3cdd9af8c018d445be460abe32588ac10a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.616880) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.617290) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.617564) ========= 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=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.672352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.672612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.739248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.739698) ========= 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=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052902 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.823299) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.823553) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.823863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:24.824141) ========= 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=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 18:13:24-- 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% 30.2M=0s 2015-12-21 18:13:25 (30.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217009 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:25.055080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:25.055482) ========= 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=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.101305 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:25.167124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 18:13:25.167429) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9c9cff3cdd9af8c018d445be460abe32588ac10a --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 9c9cff3cdd9af8c018d445be460abe32588ac10a --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=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 18:13:25,233 truncating revision to first 12 chars 2015-12-21 18:13:25,233 Setting DEBUG logging. 2015-12-21 18:13:25,233 attempt 1/10 2015-12-21 18:13:25,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9c9cff3cdd9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 18:13:25,492 unpacking tar archive at: fx-team-9c9cff3cdd9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.908289 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 18:13:26.367449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:26.367724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:26.388252) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:26.388495) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 18:13:26.388847) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-21 18:13:26.389134) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:13:26 INFO - MultiFileLogger online at 20151221 18:13:26 in /builds/slave/test-pgo 18:13:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:13:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:13:26 INFO - {'append_to_log': False, 18:13:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:13:26 INFO - 'blob_upload_branch': 'Fx-Team', 18:13:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:13:26 INFO - 'branch': 'Fx-Team', 18:13:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:13:26 INFO - 'config_files': ('talos/linux_config.py',), 18:13:26 INFO - 'default_actions': ('clobber', 18:13:26 INFO - 'read-buildbot-config', 18:13:26 INFO - 'download-and-extract', 18:13:26 INFO - 'populate-webroot', 18:13:26 INFO - 'create-virtualenv', 18:13:26 INFO - 'install', 18:13:26 INFO - 'run-tests'), 18:13:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:13:26 INFO - 'download_minidump_stackwalk': True, 18:13:26 INFO - 'download_symbols': 'ondemand', 18:13:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:13:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:13:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:13:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:13:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:13:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:13:26 INFO - 'installer_path': 'installer.exe', 18:13:26 INFO - 'log_level': 'info', 18:13:26 INFO - 'log_name': 'talos', 18:13:26 INFO - 'log_to_console': True, 18:13:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:13:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:13:26 INFO - 'opt_config_files': (), 18:13:26 INFO - 'pip_index': False, 18:13:26 INFO - 'sps_profile': False, 18:13:26 INFO - 'sps_profile_interval': 0, 18:13:26 INFO - 'suite': 'dromaeojs-e10s', 18:13:26 INFO - 'system_bits': '64', 18:13:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:13:26 INFO - 'title': 'talos-linux64-ix-041', 18:13:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:13:26 INFO - 'use_talos_json': True, 18:13:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:13:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:13:26 INFO - 'work_dir': 'build'} 18:13:26 INFO - ##### 18:13:26 INFO - ##### Running clobber step. 18:13:26 INFO - ##### 18:13:26 INFO - Running pre-action listener: _resource_record_pre_action 18:13:26 INFO - Running main action method: clobber 18:13:26 INFO - rmtree: /builds/slave/test-pgo/build 18:13:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:13:32 INFO - Running post-action listener: _resource_record_post_action 18:13:32 INFO - ##### 18:13:32 INFO - ##### Running read-buildbot-config step. 18:13:32 INFO - ##### 18:13:32 INFO - Running pre-action listener: _resource_record_pre_action 18:13:32 INFO - Running main action method: read_buildbot_config 18:13:32 INFO - Using buildbot properties: 18:13:32 INFO - { 18:13:32 INFO - "project": "", 18:13:32 INFO - "product": "firefox", 18:13:32 INFO - "script_repo_revision": "production", 18:13:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:13:32 INFO - "repository": "", 18:13:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:13:32 INFO - "buildid": "20151221143014", 18:13:32 INFO - "pgo_build": "True", 18:13:32 INFO - "basedir": "/builds/slave/test-pgo", 18:13:32 INFO - "buildnumber": 397, 18:13:32 INFO - "slavename": "talos-linux64-ix-041", 18:13:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:13:32 INFO - "platform": "ubuntu64_hw", 18:13:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:13:32 INFO - "branch": "fx-team", 18:13:32 INFO - "repo_path": "integration/fx-team", 18:13:32 INFO - "revision": "9c9cff3cdd9af8c018d445be460abe32588ac10a", 18:13:32 INFO - "stage_platform": "linux64-pgo", 18:13:32 INFO - "builduid": "f9c88fd90b224fff99e4cd5dcbee64c6", 18:13:32 INFO - "slavebuilddir": "test" 18:13:32 INFO - } 18:13:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:13:32 INFO - Running post-action listener: _resource_record_post_action 18:13:32 INFO - ##### 18:13:32 INFO - ##### Running download-and-extract step. 18:13:32 INFO - ##### 18:13:32 INFO - Running pre-action listener: _resource_record_pre_action 18:13:32 INFO - Running main action method: download_and_extract 18:13:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:13:32 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')]} 18:13:32 INFO - https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:13:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/test_packages.json 18:13:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/test_packages.json 18:13:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:13:33 INFO - Downloaded 1302 bytes. 18:13:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:13:33 INFO - Using the following test package requirements: 18:13:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:13:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:13:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:33 INFO - u'jsshell-linux-x86_64.zip'], 18:13:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:13:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:13:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:13:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:13:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:13:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:13:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:13:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:13: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')]} 18:13:33 INFO - https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:13:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:13:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:13:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:40 INFO - Downloaded 23175546 bytes. 18:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:13:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:13:41 INFO - Return code: 0 18:13:41 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 18:13: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')]} 18:13:41 INFO - https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:42 INFO - Downloaded 23175546 bytes. 18:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:13:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:13:43 INFO - Return code: 0 18:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:43 INFO - https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:45 INFO - Downloaded 11132277 bytes. 18:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:13:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:13:45 INFO - Return code: 0 18:13:45 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')]} 18:13:45 INFO - https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIC-IfgvQdO9m83rxU0Nuw/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 18:13:47 INFO - Downloaded 54941348 bytes. 18:13:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:13:47 INFO - mkdir: /builds/slave/test-pgo/properties 18:13:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:13:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:13:47 INFO - Contents: 18:13:47 INFO - build_url:https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:13:47 INFO - Running post-action listener: _resource_record_post_action 18:13:47 INFO - Running post-action listener: set_extra_try_arguments 18:13:47 INFO - ##### 18:13:47 INFO - ##### Running populate-webroot step. 18:13:47 INFO - ##### 18:13:47 INFO - Running pre-action listener: _resource_record_pre_action 18:13:47 INFO - Running main action method: populate_webroot 18:13:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:13:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:13:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:13:47 INFO - '--tppagecycles', 18:13:47 INFO - '7'], 18:13:47 INFO - 'tests': ['tsvgm']}}, 18:13:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:13:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:13:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:13:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:13:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'tests': ['damp', 'tps']}, 18:13:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['damp', 'tps']}, 18:13:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:13:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:13:47 INFO - 'other': {'tests': ['a11yr', 18:13:47 INFO - 'ts_paint', 18:13:47 INFO - 'tpaint', 18:13:47 INFO - 'sessionrestore', 18:13:47 INFO - 'sessionrestore_no_auto_restore']}, 18:13:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['a11yr', 18:13:47 INFO - 'ts_paint', 18:13:47 INFO - 'tpaint', 18:13:47 INFO - 'sessionrestore', 18:13:47 INFO - 'sessionrestore_no_auto_restore']}, 18:13:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['a11yr', 18:13:47 INFO - 'ts_paint', 18:13:47 INFO - 'tpaint', 18:13:47 INFO - 'sessionrestore', 18:13:47 INFO - 'sessionrestore_no_auto_restore']}, 18:13:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['a11yr', 18:13:47 INFO - 'ts_paint', 18:13:47 INFO - 'tpaint', 18:13:47 INFO - 'sessionrestore', 18:13:47 INFO - 'sessionrestore_no_auto_restore']}, 18:13:47 INFO - 'other_l64': {'tests': ['a11yr', 18:13:47 INFO - 'ts_paint', 18:13:47 INFO - 'tpaint', 18:13:47 INFO - 'sessionrestore', 18:13:47 INFO - 'sessionrestore_no_auto_restore']}, 18:13:47 INFO - 'other_nol64': {'tests': ['a11yr', 18:13:47 INFO - 'ts_paint', 18:13:47 INFO - 'tpaint', 18:13:47 INFO - 'sessionrestore', 18:13:47 INFO - 'sessionrestore_no_auto_restore']}, 18:13:47 INFO - 'svgr': {'tests': ['tsvgx', 18:13:47 INFO - 'tsvgr_opacity', 18:13:47 INFO - 'tart', 18:13:47 INFO - 'tscrollx', 18:13:47 INFO - 'cart']}, 18:13:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['tsvgx', 18:13:47 INFO - 'tsvgr_opacity', 18:13:47 INFO - 'tart', 18:13:47 INFO - 'tscrollx', 18:13:47 INFO - 'cart']}, 18:13:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'tests': ['tp5o']}, 18:13:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'talos_options': ['--e10s'], 18:13:47 INFO - 'tests': ['tp5o']}, 18:13:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'talos_options': ['--xperf_path', 18:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:13:47 INFO - 'tests': ['tp5n']}, 18:13:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:47 INFO - 'talos_options': ['--e10s', 18:13:47 INFO - '--xperf_path', 18:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:13:47 INFO - 'tests': ['tp5n']}}, 18:13:47 INFO - 'talos.zip': {'path': '', 18:13:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:13:47 INFO - Running post-action listener: _resource_record_post_action 18:13:47 INFO - ##### 18:13:47 INFO - ##### Running create-virtualenv step. 18:13:47 INFO - ##### 18:13:47 INFO - Running pre-action listener: _resource_record_pre_action 18:13:47 INFO - Running main action method: create_virtualenv 18:13:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:13:47 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 18:13:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:13:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:13:47 INFO - Using real prefix '/usr' 18:13:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:13:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:13:50 INFO - Installing pip.................done. 18:13:50 INFO - Return code: 0 18:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:13: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')]} 18:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13: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')]} 18:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:13:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:13:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:13:50 INFO - Using env: {'DISPLAY': ':0', 18:13:50 INFO - 'HOME': '/home/cltbld', 18:13:50 INFO - 'LANG': 'en_US.UTF-8', 18:13:50 INFO - 'LANGUAGE': 'en_US:en', 18:13:50 INFO - 'LOGNAME': 'cltbld', 18:13:50 INFO - 'MAIL': '/var/mail/cltbld', 18:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:50 INFO - 'MOZ_NO_REMOTE': '1', 18:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:50 INFO - 'NO_EM_RESTART': '1', 18:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:13:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:13:50 INFO - 'SHELL': '/bin/bash', 18:13:50 INFO - 'SHLVL': '1', 18:13:50 INFO - 'TERM': 'linux', 18:13:50 INFO - 'TMOUT': '86400', 18:13:50 INFO - 'USER': 'cltbld', 18:13:50 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:50 INFO - '_': '/tools/buildbot/bin/python'} 18:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:50 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 18:13:50 INFO - Cleaning up... 18:13:50 INFO - Return code: 0 18:13:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:13: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')]} 18:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13: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')]} 18:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:13:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:13:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:13:50 INFO - Using env: {'DISPLAY': ':0', 18:13:50 INFO - 'HOME': '/home/cltbld', 18:13:50 INFO - 'LANG': 'en_US.UTF-8', 18:13:50 INFO - 'LANGUAGE': 'en_US:en', 18:13:50 INFO - 'LOGNAME': 'cltbld', 18:13:50 INFO - 'MAIL': '/var/mail/cltbld', 18:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:50 INFO - 'MOZ_NO_REMOTE': '1', 18:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:50 INFO - 'NO_EM_RESTART': '1', 18:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:13:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:13:50 INFO - 'SHELL': '/bin/bash', 18:13:50 INFO - 'SHLVL': '1', 18:13:50 INFO - 'TERM': 'linux', 18:13:50 INFO - 'TMOUT': '86400', 18:13:50 INFO - 'USER': 'cltbld', 18:13:50 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:50 INFO - '_': '/tools/buildbot/bin/python'} 18:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:50 INFO - Downloading/unpacking psutil>=0.7.1 18:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:13:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:13:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:13:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:13:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:13:52 INFO - Installing collected packages: psutil 18:13:52 INFO - Running setup.py install for psutil 18:13:52 INFO - building 'psutil._psutil_linux' extension 18:13:52 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 18:13:56 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 18:13:56 INFO - building 'psutil._psutil_posix' extension 18:13:56 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 18:13:56 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 18:13:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:13:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:13:56 INFO - Successfully installed psutil 18:13:56 INFO - Cleaning up... 18:13:56 INFO - Return code: 0 18:13:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:13: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')]} 18:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13: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')]} 18:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:13:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:13:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:13:56 INFO - Using env: {'DISPLAY': ':0', 18:13:56 INFO - 'HOME': '/home/cltbld', 18:13:56 INFO - 'LANG': 'en_US.UTF-8', 18:13:56 INFO - 'LANGUAGE': 'en_US:en', 18:13:56 INFO - 'LOGNAME': 'cltbld', 18:13:56 INFO - 'MAIL': '/var/mail/cltbld', 18:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:56 INFO - 'MOZ_NO_REMOTE': '1', 18:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:56 INFO - 'NO_EM_RESTART': '1', 18:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:13:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:13:56 INFO - 'SHELL': '/bin/bash', 18:13:56 INFO - 'SHLVL': '1', 18:13:56 INFO - 'TERM': 'linux', 18:13:56 INFO - 'TMOUT': '86400', 18:13:56 INFO - 'USER': 'cltbld', 18:13:56 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:56 INFO - '_': '/tools/buildbot/bin/python'} 18:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:13:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:13:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:13:58 INFO - Installing collected packages: mozsystemmonitor 18:13:58 INFO - Running setup.py install for mozsystemmonitor 18:13:58 INFO - Successfully installed mozsystemmonitor 18:13:58 INFO - Cleaning up... 18:13:58 INFO - Return code: 0 18:13:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:58 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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:13:58 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 18:13:58 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 18:13:58 INFO - Using env: {'DISPLAY': ':0', 18:13:58 INFO - 'HOME': '/home/cltbld', 18:13:58 INFO - 'LANG': 'en_US.UTF-8', 18:13:58 INFO - 'LANGUAGE': 'en_US:en', 18:13:58 INFO - 'LOGNAME': 'cltbld', 18:13:58 INFO - 'MAIL': '/var/mail/cltbld', 18:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:58 INFO - 'MOZ_NO_REMOTE': '1', 18:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:13:58 INFO - 'NO_EM_RESTART': '1', 18:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:13:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:13:58 INFO - 'SHELL': '/bin/bash', 18:13:58 INFO - 'SHLVL': '1', 18:13:58 INFO - 'TERM': 'linux', 18:13:58 INFO - 'TMOUT': '86400', 18:13:58 INFO - 'USER': 'cltbld', 18:13:58 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:58 INFO - '_': '/tools/buildbot/bin/python'} 18:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:14:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:14:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:14:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:14:00 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 18:14:00 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 18:14:00 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 18:14:00 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 18:14:00 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 18:14:00 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 18:14:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:14:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:14:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14:01 INFO - Downloading docopt-0.6.1.tar.gz 18:14:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:14:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:14:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:14:01 INFO - Running setup.py install for blobuploader 18:14:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:14:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:14:01 INFO - Running setup.py install for requests 18:14:01 INFO - Running setup.py install for docopt 18:14:02 INFO - Successfully installed blobuploader requests docopt 18:14:02 INFO - Cleaning up... 18:14:02 INFO - Return code: 0 18:14:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:02 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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:14:02 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 18:14:02 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 18:14:02 INFO - Using env: {'DISPLAY': ':0', 18:14:02 INFO - 'HOME': '/home/cltbld', 18:14:02 INFO - 'LANG': 'en_US.UTF-8', 18:14:02 INFO - 'LANGUAGE': 'en_US:en', 18:14:02 INFO - 'LOGNAME': 'cltbld', 18:14:02 INFO - 'MAIL': '/var/mail/cltbld', 18:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:02 INFO - 'MOZ_NO_REMOTE': '1', 18:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:02 INFO - 'NO_EM_RESTART': '1', 18:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:14:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:14:02 INFO - 'SHELL': '/bin/bash', 18:14:02 INFO - 'SHLVL': '1', 18:14:02 INFO - 'TERM': 'linux', 18:14:02 INFO - 'TMOUT': '86400', 18:14:02 INFO - 'USER': 'cltbld', 18:14:02 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:02 INFO - '_': '/tools/buildbot/bin/python'} 18:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:14:02 INFO - Running setup.py (path:/tmp/pip-lvYT86-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:14:02 INFO - Running setup.py (path:/tmp/pip-Zc6l6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:14:02 INFO - Running setup.py (path:/tmp/pip-rd3Kfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:14:02 INFO - Running setup.py (path:/tmp/pip-FPa5E6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:14:02 INFO - Running setup.py (path:/tmp/pip-GiwtPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:14:02 INFO - Running setup.py (path:/tmp/pip-4_whMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:14:02 INFO - Running setup.py (path:/tmp/pip-cnha1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:14:02 INFO - Running setup.py (path:/tmp/pip-CG2aDm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:14:02 INFO - Running setup.py (path:/tmp/pip-isIqVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:14:02 INFO - Running setup.py (path:/tmp/pip-g3M0Mo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:14:03 INFO - Running setup.py (path:/tmp/pip-vgGT6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:14:03 INFO - Running setup.py (path:/tmp/pip-SHfMTJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:14:03 INFO - Running setup.py (path:/tmp/pip-iNeu0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:14:03 INFO - Running setup.py (path:/tmp/pip-xJbPBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:14:03 INFO - Running setup.py (path:/tmp/pip-at4m4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:14:03 INFO - Running setup.py (path:/tmp/pip-I6u5p0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:14:03 INFO - Running setup.py (path:/tmp/pip-G9KNCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:14:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:14:03 INFO - Running setup.py install for manifestparser 18:14:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:14:03 INFO - Running setup.py install for mozcrash 18:14:03 INFO - Running setup.py install for mozdebug 18:14:03 INFO - Running setup.py install for mozdevice 18:14:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:14:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:14:03 INFO - Running setup.py install for mozfile 18:14:04 INFO - Running setup.py install for mozhttpd 18:14:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Running setup.py install for mozinfo 18:14:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Running setup.py install for mozInstall 18:14:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Running setup.py install for mozleak 18:14:04 INFO - Running setup.py install for mozlog 18:14:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Running setup.py install for moznetwork 18:14:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Running setup.py install for mozprocess 18:14:04 INFO - Running setup.py install for mozprofile 18:14:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:14:04 INFO - Running setup.py install for mozrunner 18:14:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:14:05 INFO - Running setup.py install for mozscreenshot 18:14:05 INFO - Running setup.py install for moztest 18:14:05 INFO - Running setup.py install for mozversion 18:14:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:14:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:14:05 INFO - Cleaning up... 18:14:05 INFO - Return code: 0 18:14:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:14:05 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 18:14:05 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 18:14:05 INFO - Using env: {'DISPLAY': ':0', 18:14:05 INFO - 'HOME': '/home/cltbld', 18:14:05 INFO - 'LANG': 'en_US.UTF-8', 18:14:05 INFO - 'LANGUAGE': 'en_US:en', 18:14:05 INFO - 'LOGNAME': 'cltbld', 18:14:05 INFO - 'MAIL': '/var/mail/cltbld', 18:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:05 INFO - 'MOZ_NO_REMOTE': '1', 18:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:05 INFO - 'NO_EM_RESTART': '1', 18:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:14:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:14:05 INFO - 'SHELL': '/bin/bash', 18:14:05 INFO - 'SHLVL': '1', 18:14:05 INFO - 'TERM': 'linux', 18:14:05 INFO - 'TMOUT': '86400', 18:14:05 INFO - 'USER': 'cltbld', 18:14:05 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:05 INFO - '_': '/tools/buildbot/bin/python'} 18:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:14:05 INFO - Running setup.py (path:/tmp/pip-t1xs2W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:14:05 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)) 18:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:14:05 INFO - Running setup.py (path:/tmp/pip-mgoMLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:14:05 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)) 18:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:14:05 INFO - Running setup.py (path:/tmp/pip-qeBPaO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:14:05 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)) 18:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:14:05 INFO - Running setup.py (path:/tmp/pip-_iwjlx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:14:05 INFO - Running setup.py (path:/tmp/pip-Bsh9Iv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:14:05 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)) 18:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:14:05 INFO - Running setup.py (path:/tmp/pip-glaZCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:14:05 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)) 18:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:14:05 INFO - Running setup.py (path:/tmp/pip-Bntmn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:14:06 INFO - Running setup.py (path:/tmp/pip-FNoTEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:14:06 INFO - Running setup.py (path:/tmp/pip-0GGlqV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:14:06 INFO - Running setup.py (path:/tmp/pip-7aRsaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:14:06 INFO - Running setup.py (path:/tmp/pip-TG2Q8z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:14:06 INFO - Running setup.py (path:/tmp/pip-KXGs6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:14:06 INFO - Running setup.py (path:/tmp/pip-mUPLy3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:14:06 INFO - Running setup.py (path:/tmp/pip-TSlTny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:14:06 INFO - Running setup.py (path:/tmp/pip-hBu0fK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:14:06 INFO - Running setup.py (path:/tmp/pip-cxh8RJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:14:06 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)) 18:14:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:14:06 INFO - Running setup.py (path:/tmp/pip-qwFiGK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:14:06 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)) 18:14:06 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)) 18:14:06 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)) 18:14:06 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)) 18:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:14:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:14:06 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 18:14:06 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 18:14:06 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 18:14:06 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 18:14:06 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 18:14:06 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 18:14:08 INFO - Downloading blessings-1.5.1.tar.gz 18:14:08 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 18:14:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:14:08 INFO - Installing collected packages: blessings 18:14:08 INFO - Running setup.py install for blessings 18:14:08 INFO - Successfully installed blessings 18:14:08 INFO - Cleaning up... 18:14:08 INFO - Return code: 0 18:14:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:14:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:14:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:14:08 INFO - Reading from file tmpfile_stdout 18:14:08 INFO - Current package versions: 18:14:08 INFO - argparse == 1.2.1 18:14:08 INFO - blessings == 1.5.1 18:14:08 INFO - blobuploader == 1.2.4 18:14:08 INFO - docopt == 0.6.1 18:14:08 INFO - manifestparser == 1.1 18:14:08 INFO - mozInstall == 1.12 18:14:08 INFO - mozcrash == 0.16 18:14:08 INFO - mozdebug == 0.1 18:14:08 INFO - mozdevice == 0.47 18:14:08 INFO - mozfile == 1.2 18:14:08 INFO - mozhttpd == 0.7 18:14:08 INFO - mozinfo == 0.9 18:14:08 INFO - mozleak == 0.1 18:14:08 INFO - mozlog == 3.1 18:14:08 INFO - moznetwork == 0.27 18:14:08 INFO - mozprocess == 0.22 18:14:08 INFO - mozprofile == 0.28 18:14:08 INFO - mozrunner == 6.11 18:14:08 INFO - mozscreenshot == 0.1 18:14:08 INFO - mozsystemmonitor == 0.0 18:14:08 INFO - moztest == 0.7 18:14:08 INFO - mozversion == 1.4 18:14:08 INFO - psutil == 3.1.1 18:14:08 INFO - requests == 1.2.3 18:14:08 INFO - wsgiref == 0.1.2 18:14:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:14:08 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')]} 18:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:08 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')]} 18:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:08 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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:14:08 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 18:14:08 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 18:14:08 INFO - Using env: {'DISPLAY': ':0', 18:14:08 INFO - 'HOME': '/home/cltbld', 18:14:08 INFO - 'LANG': 'en_US.UTF-8', 18:14:08 INFO - 'LANGUAGE': 'en_US:en', 18:14:08 INFO - 'LOGNAME': 'cltbld', 18:14:08 INFO - 'MAIL': '/var/mail/cltbld', 18:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:08 INFO - 'MOZ_NO_REMOTE': '1', 18:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:08 INFO - 'NO_EM_RESTART': '1', 18:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:14:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:14:08 INFO - 'SHELL': '/bin/bash', 18:14:08 INFO - 'SHLVL': '1', 18:14:08 INFO - 'TERM': 'linux', 18:14:08 INFO - 'TMOUT': '86400', 18:14:08 INFO - 'USER': 'cltbld', 18:14:08 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:08 INFO - '_': '/tools/buildbot/bin/python'} 18:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 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)) 18:14:09 INFO - Cleaning up... 18:14:09 INFO - Return code: 0 18:14:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:09 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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:14:09 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 18:14:09 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 18:14:09 INFO - Using env: {'DISPLAY': ':0', 18:14:09 INFO - 'HOME': '/home/cltbld', 18:14:09 INFO - 'LANG': 'en_US.UTF-8', 18:14:09 INFO - 'LANGUAGE': 'en_US:en', 18:14:09 INFO - 'LOGNAME': 'cltbld', 18:14:09 INFO - 'MAIL': '/var/mail/cltbld', 18:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:09 INFO - 'MOZ_NO_REMOTE': '1', 18:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:09 INFO - 'NO_EM_RESTART': '1', 18:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:14:09 INFO - 'PWD': '/builds/slave/test-pgo', 18:14:09 INFO - 'SHELL': '/bin/bash', 18:14:09 INFO - 'SHLVL': '1', 18:14:09 INFO - 'TERM': 'linux', 18:14:09 INFO - 'TMOUT': '86400', 18:14:09 INFO - 'USER': 'cltbld', 18:14:09 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:09 INFO - '_': '/tools/buildbot/bin/python'} 18:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:09 INFO - Downloading/unpacking jsonschema 18:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:14:11 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 18:14:11 INFO - Downloading/unpacking functools32 (from jsonschema) 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 INFO - Downloading functools32-3.2.3-2.tar.gz 18:14:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:14:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:14:11 INFO - warning: no files found matching '*.txt' 18:14:11 INFO - no previously-included directories found matching 'build' 18:14:11 INFO - no previously-included directories found matching 'dist' 18:14:11 INFO - no previously-included directories found matching '.git*' 18:14:11 INFO - Installing collected packages: jsonschema, functools32 18:14:11 INFO - Running setup.py install for functools32 18:14:11 INFO - warning: no files found matching '*.txt' 18:14:11 INFO - no previously-included directories found matching 'build' 18:14:11 INFO - no previously-included directories found matching 'dist' 18:14:11 INFO - no previously-included directories found matching '.git*' 18:14:11 INFO - Successfully installed jsonschema functools32 18:14:11 INFO - Cleaning up... 18:14:11 INFO - Return code: 0 18:14:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:14:11 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')]} 18:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:11 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')]} 18:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:11 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 0x7fd39f55cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, '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': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', '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 18:14:11 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 18:14:11 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 18:14:11 INFO - Using env: {'DISPLAY': ':0', 18:14:11 INFO - 'HOME': '/home/cltbld', 18:14:11 INFO - 'LANG': 'en_US.UTF-8', 18:14:11 INFO - 'LANGUAGE': 'en_US:en', 18:14:11 INFO - 'LOGNAME': 'cltbld', 18:14:11 INFO - 'MAIL': '/var/mail/cltbld', 18:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:11 INFO - 'MOZ_NO_REMOTE': '1', 18:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:11 INFO - 'NO_EM_RESTART': '1', 18:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:14:11 INFO - 'PWD': '/builds/slave/test-pgo', 18:14:11 INFO - 'SHELL': '/bin/bash', 18:14:11 INFO - 'SHLVL': '1', 18:14:11 INFO - 'TERM': 'linux', 18:14:11 INFO - 'TMOUT': '86400', 18:14:11 INFO - 'USER': 'cltbld', 18:14:11 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:11 INFO - '_': '/tools/buildbot/bin/python'} 18:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:11 INFO - Downloading/unpacking flake8 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:14:13 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 18:14:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:14:13 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 18:14:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 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 18:14:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:14:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:14:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:14:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:14:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:14:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:14:14 INFO - no previously-included directories found matching 'docs/_build' 18:14:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:14:14 INFO - Running setup.py install for pep8 18:14:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:14:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:14:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:14:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:14:14 INFO - no previously-included directories found matching 'docs/_build' 18:14:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:14:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:14:14 INFO - Cleaning up... 18:14:14 INFO - Return code: 0 18:14:14 INFO - Running post-action listener: _resource_record_post_action 18:14:14 INFO - Running post-action listener: _start_resource_monitoring 18:14:14 INFO - Starting resource monitoring. 18:14:14 INFO - ##### 18:14:14 INFO - ##### Running install step. 18:14:14 INFO - ##### 18:14:14 INFO - Running pre-action listener: _resource_record_pre_action 18:14:14 INFO - Running main action method: install 18:14:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:14:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:14:14 INFO - Reading from file tmpfile_stdout 18:14:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:14:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:14:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:14:14 INFO - Reading from file tmpfile_stdout 18:14:14 INFO - Output received: 18:14:14 INFO - Usage: mozinstall [options] installer 18:14:14 INFO - Options: 18:14:14 INFO - -h, --help show this help message and exit 18:14:14 INFO - -d DEST, --destination=DEST 18:14:14 INFO - Directory to install application into. [default: 18:14:14 INFO - "/builds/slave/test-pgo"] 18:14:14 INFO - --app=APP Application being installed. [default: firefox] 18:14:14 INFO - mkdir: /builds/slave/test-pgo/build/application 18:14:14 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'] 18:14:14 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 18:14:30 INFO - Reading from file tmpfile_stdout 18:14:30 INFO - Output received: 18:14:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:14:30 INFO - Running post-action listener: _resource_record_post_action 18:14:30 INFO - ##### 18:14:30 INFO - ##### Running run-tests step. 18:14:30 INFO - ##### 18:14:30 INFO - Running pre-action listener: _resource_record_pre_action 18:14:30 INFO - Running main action method: run_tests 18:14:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:14:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:14:30 INFO - Python 2.7.3 18:14:30 INFO - Return code: 0 18:14:30 INFO - grabbing minidump binary from tooltool 18:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:30 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 0x2c18660>, '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 0x2c19560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c19a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:14:30 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 18:14:30 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 18:14:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:14:30 INFO - Return code: 0 18:14:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:14:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:14:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:14:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:14:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:14:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:14:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:14:31 INFO - Return code: 0 18:14:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:14:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:14:31 INFO - Using env: {'DISPLAY': ':0', 18:14:31 INFO - 'HOME': '/home/cltbld', 18:14:31 INFO - 'LANG': 'en_US.UTF-8', 18:14:31 INFO - 'LANGUAGE': 'en_US:en', 18:14:31 INFO - 'LOGNAME': 'cltbld', 18:14:31 INFO - 'MAIL': '/var/mail/cltbld', 18:14:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:14:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:31 INFO - 'MOZ_NO_REMOTE': '1', 18:14:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:31 INFO - 'NO_EM_RESTART': '1', 18:14:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:14:31 INFO - 'PWD': '/builds/slave/test-pgo', 18:14:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:14:31 INFO - 'SHELL': '/bin/bash', 18:14:31 INFO - 'SHLVL': '1', 18:14:31 INFO - 'TERM': 'linux', 18:14:31 INFO - 'TMOUT': '86400', 18:14:31 INFO - 'USER': 'cltbld', 18:14:31 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260', 18:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:31 INFO - '_': '/tools/buildbot/bin/python'} 18:14:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:14:32 INFO - mozversion application_buildid: 20151221143014 18:14:32 INFO - mozversion application_changeset: 9c9cff3cdd9af8c018d445be460abe32588ac10a 18:14:32 INFO - mozversion application_display_name: Nightly 18:14:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:14:32 INFO - mozversion application_name: Firefox 18:14:32 INFO - mozversion application_remotingname: firefox 18:14:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:14:32 INFO - mozversion application_vendor: Mozilla 18:14:32 INFO - mozversion application_version: 46.0a1 18:14:32 INFO - mozversion platform_buildid: 20151221143014 18:14:32 INFO - mozversion platform_changeset: 9c9cff3cdd9af8c018d445be460abe32588ac10a 18:14:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:14:32 INFO - mozversion platform_version: 46.0a1 18:14:32 INFO - using testdate: 1450750472 18:14:32 INFO - actual date: 1450750472 18:14:32 INFO - starting webserver on 'localhost:35782' 18:14:32 INFO - SUITE-START | Running 3 tests 18:14:32 INFO - TEST-START | dromaeo_css 18:14:32 INFO - operating with platform_type : linux_ 18:14:32 INFO - Initialising browser for dromaeo_css test... 18:14:32 INFO - TEST-INFO | started process 3335 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDhsWdr/profile http://localhost:35782/getInfo.html) 18:14:38 INFO - PROCESS | 3335 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 18:14:39 INFO - PROCESS | 3335 | __metrics Screen width/height:1600/1200 18:14:39 INFO - PROCESS | 3335 | colorDepth:24 18:14:39 INFO - PROCESS | 3335 | Browser inner width/height: 1024/697 18:14:39 INFO - PROCESS | 3335 | __metrics 18:14:39 INFO - PROCESS | 3335 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:14:40 INFO - TEST-INFO | 3335: exit 0 18:14:40 INFO - Browser initialized. 18:14:40 INFO - Running cycle 1/1 for dromaeo_css test... 18:14:40 INFO - TEST-INFO | started process 3465 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDhsWdr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:52 INFO - PROCESS | 3465 | RSS: Main: 151207936 18:14:52 INFO - PROCESS | 3465 | 18:15:41 INFO - PROCESS | 3465 | 1450750541679 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] 18:17:50 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35782/tests/dromaeo/cssquery-ext.html) 18:17:51 INFO - PROCESS | 3465 | RSS: Main: 157966336 18:17:51 INFO - PROCESS | 3465 | 18:20:53 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35782/tests/dromaeo/cssquery-ext.html (next: http://localhost:35782/tests/dromaeo/cssquery-jquery.html) 18:20:54 INFO - PROCESS | 3465 | RSS: Main: 152756224 18:20:54 INFO - PROCESS | 3465 | 18:23:55 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35782/tests/dromaeo/cssquery-mootools.html) 18:23:56 INFO - PROCESS | 3465 | RSS: Main: 154136576 18:23:56 INFO - PROCESS | 3465 | 18:26:58 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35782/tests/dromaeo/cssquery-prototype.html) 18:26:58 INFO - PROCESS | 3465 | RSS: Main: 151703552 18:26:58 INFO - PROCESS | 3465 | 18:30:01 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35782/tests/dromaeo/cssquery-yui.html) 18:30:01 INFO - PROCESS | 3465 | RSS: Main: 153309184 18:30:01 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:35782/tests/dromaeo/cssquery-yui.html (next: http://localhost:35782/tests/dromaeo/cssquery-dojo.html) 18:33:04 INFO - PROCESS | 3465 | RSS: Main: 155717632 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | __start_tp_report 18:33:04 INFO - PROCESS | 3465 | _x_x_mozilla_page_load 18:33:04 INFO - PROCESS | 3465 | _x_x_mozilla_page_load_details 18:33:04 INFO - PROCESS | 3465 | |i|pagename|runs| 18:33:04 INFO - PROCESS | 3465 | |0;dojo.html;3206.470932296171;3249.6425393206728;3278.819664918429;3279.573655424794;3305.487649414342;5199.740012999354;5466.617336786427;5474.589405794562;5485.451454854512;5509.173623956409;5397.676139431627;5398.541124004454;5402.6758394496355;5496.890062198763;5540.085885828834;4992.9750351248285;5042.520960508764;5115.053715062707;5127.615428842833;5127.692338459686;5042.899142017158;5119.5136462036235;5151.6908985460805;5182.870428239286;5202.895942081156;4874.8537543873745;4952.925706114411;4978.6017118630425;5062.0888240116765;5101.897962040757;5010.649254552182;5022.84931452057;5037.319961805146;5066.620003499752;5099.59203263738;4992.201247800371;5009.123403404426;5012.8997420051755;5021.72380519075;5033.0688822567945;5155.84532464023;5163.922541161885;5205.479452054802;5213.895722085575;5257.526822585947;5881.558883083786;5939.67331796751;5948.553858460589;5954.642721436684;5956.16613674086;5843.386444423317;5983.58114931955;5989.2812862456785;5993.0710739835395;6005.909911351333;5469.726513674301;5505.256790333294;5544.667319960815;5548.639338442988;5560.277163968658;5958.493528050078;6000.579959402888;6014.548908831767;6015.608985415934;6018.638881667026;5736.42635736423;5846.970765146147;5850.444207800252;5865.35481097079;5867.70661466925;5954.285485741739;5988.9101663475085;5994.100884867305;6018.8194354169445;6050.304215015241;5881.735321910524;5902.704864756745;5933;5937.079752638348;5938.020226662638;5798.855028624318;5801.738921748447;5805.651660900359;5923.111533270044;5932;4559.658025648089;4584.358189853357;4587.311903214478;4589.128065667513;4641.767911604406;4057.9391309130388;4066.1664358806374;4071.145059537471;4083.4079058536345;4110.77390743512;5365.248865158881;5442.374126975369;5464.535514481314;5568.6101972862325;5682.147677848356;5969.134475501028;5990.371011043865;5999.730012149464;6003.039513677878;6031.819045428644;5592.496675299161;5594.272744543184;5595.972020139955;5598.3282006159525;5608.859778505488;5020.623453241022;5094.719790411489;5124.897502049938;5152.355955505562;5205.167173252262;6054.122152287893;6080.0879868019265;6093.9390606093375;6096.75612975476;6099.085137229451;6017.699115044143;6019.458248757633;6021.789237376846;6022.668753218615;6029.246344206974;5844.620099693507;5875.73559189846;5908.7045647718305;5936.406359364029;5969.52243820502;5881.411858814085;5894.705264736832;5909.5863289569315;5926.2295901532525;5936;5977.193078934288;5977.820665380045;5978.730957106854;5978.790742323998;5982.162497250475;5453.700046497481;5621.213030175697;5639.6334238274385;5672.262605861211;5753.223314852608;5791;5795.59430839854;5812;5815.651060936358;5841.707914604338;5679.6876171810945;5729.054705973468;5737.397573254748;5741.081426971665;5743.712814359182;5559.833205003856;5625.634333768292;5766.163906233656;5807.361190269152;5885.3820348862755;5683.7442315095095;5696.259486266758;5699.316082070012;5703.087505999186;5731.713414329351 18:33:04 INFO - PROCESS | 3465 | |1;ext.html;560.8107777456972;598.8832177725343;600.1567797244871;617.3548641669455;619.4394073363602;38159;38473.61526384735;38629.99999999996;38866.80566597167;38910.80544597273;44116.11767764643;44140.3378949316;44711.105777884426;44787.328190077176;44886.10227795442;8793.999999999984;8894.955525222365;8965.910340896573;8987.37088403812;9011.504367259799;8700.216980471756;8712.782180445476;8804.339674524404;8834.160754728291;8836.558172091402;8769.473831570127;8806.163414475615;8848.026717061119;8858.778530536723;8915.108489151065;8778.166074222938;8824.514651694155;8825.249853762438;8828.823423531558;8920.197182253596;8682.826343473158;8813.338999575057;8813.867791983126;8867.73396798097;8872.423292486032;39640.80179599083;40479.19041619181;40490;40493.595064049274;40501.79749101265;3325.534425180477;3341.4319565673895;3344.464885618314;3360.882369117069;3481.3385456763385;29888.551671724723;29930.85034574813;30222.09333719992;30358;31049;3875.476810630557;3893.10458594522;3900.726949113563;3911.2764138634443;4039.818208180639;271004;272129.6393518039;272481;273816;273960;53612.46387536153;54954;67891.32108678948;69149.30850691529;69606.30393696099;60696.39303606907;61355.386446134966;61582;61656.69171654113;61729.382706172364;15233.466828661165;15395.923020385051;15537.45618903333;15545.22273886301;15571;11670.649880503599;11791.646250612495;11796.410179490991;11867.169298149047;11918.702032449084;20571.177152913715;20873.1650733972;20911.68632470514;20970.475738106365;21014.474638133863;7662.61686915652;7841.803954901059;7929.405294602928;7989.440739148204;7995.240452157036;877.3507604372846;877.8376000439939;900.0639335091562;1072.6299426697776;1123.2754873106965;27547.173584792487;27981.300467488476;27982.86008569944;28129.156125315865;28378.43243135126;1021.7394564386034;1024.7335692719798;1025.9230557708202;1030.1346868630387;1099.290957332516;14725.779113313309;14772;14897.47858824936;14939.103653780809;15004.699906002037;316454;317823;319874;320151;322042;51784;51893.22160167601;52033.21950170751;52155.088368372526;52166.47833521692;1311.2591385867145;1326.476041963419;1336.5322137251885;1346.5690978886857;1358.5448874626913;26003.479930401663;27157.321066973484;27246.4173785257;27449.31376715518;27557.724422755517;45755.77122114368;46231;46267.305990410845;46280.30579541242;46358.30462543132;299732;301332;301513;302626;304189;32091.67908320887;32362.514562281114;32374.514382284757;32409;32494.675053249164;36884.81557592195;37163.44254836126;37338.62661373351;37680.81159594184;38408.807955960045;32174.03477895667;32553.186170345933;32805.671943280264;33062.17344566309;33154.17114572155;33054;33217.50173747444;35123;36798.63201367952;36842.8157859209;33281.334373312886;33688.831555842065;33695.15762105967;33774;33844.492332614536;29077.41845163127;30963.380732385678;31382;31443.842780785948;31491.527627085154;23901.521969560858;24017.759822401553;24111.23824685367;24213.51572968566;24341.878290609144 18:33:04 INFO - PROCESS | 3465 | |2;jquery.html;363.94176931690936;366.1578369749576;366.9302832461832;368.26163542098095;369.20989083361593;11715.589954351579;12124.93937530311;16464.423745168908;17307.39424120156;17941.372051978182;17250.137493125356;17503.212355444004;17543.210555525002;17608.735868961976;17697.734533982002;5983.910241346383;6101.511879049687;6125;6126.417990290915;6153.0155175171985;5173;5998;6068.635881847081;6068.878622427549;6110.480609148228;6051;6065.545084118687;6084.574079814415;6085.330613632497;6092;6073.119397687333;6090.23872015998;6184.8144555663175;6408.67956602168;6422.935770642281;6116.235470566179;6133.6626485543275;6176.69116544171;6180.690965451709;6396.072569477446;21916.23293184747;22189.001494932767;22321.44196395087;22439.102435902543;22566.661500077513;2065.297798748433;2121.3847984084596;2228.3760547046854;2330.5804955108074;2459.0655550890724;13538.255395953218;13694.863051369559;13951.860481395157;14151.29243537819;14301.213433261166;1861.6649003179423;1871.709884967832;1941.4563922101834;1941.5243265400068;1989.9900500497404;67422.66288668575;70413.29586704119;70526.294737053;72008;72277.6386118066;15366.923165384325;15672.451464198699;15690.450834220748;15692.68614627701;15705.764413533807;12880.742385152245;13176.868231317565;13206.405711742995;24544.631830522558;24563.38591535226;5918.2898052234;6054.091886217103;6885.724571017204;7436.070491188601;7490.176080631126;7145.1425828900865;7154.749583764543;7215.639218039077;7215.96392018047;7291.416686665054;4516.209663308908;4612.469565999886;4615.215413379734;4621.953780462152;4646.674732768742;1860.3488778927538;1873.8219869112413;1895.9810401895804;1902.267626963629;1903.2196799312217;897.1432282170512;907.3512438606429;913.7578541686458;963.4556475591269;980.9264305176997;16327.83672163287;16614.58463538397;16698.58253543671;16703.83296167023;16836;910.2717825739383;925.7824411263348;946.8674385586023;960.4861399151421;966.4008314844841;9442.52787360643;9720.222382209406;9781.51092445389;9791.118799308097;9896.599721614606;500559;503106;503865;506114;510696;74972.25027749653;75702;76135;76352.56413461408;78302;1062.0494657281845;1074.215822449616;1075.8063548561177;1093.50245638236;1116.4027245423658;14917.925410372878;14920.179390133648;15016.399344026117;15231.314590843216;15546.689066218838;29567;32682.34635307328;34144;34406;35209.647903520636;44025.16978627659;44591;44871.55128448674;45257.094858102;47010.29484557803;9272.629094836131;9487;9607.279454041114;9667;9738;11313.604023859125;11387.202895797545;11432.14258930567;16615.3353865844;16995.23521441563;8287.709930152416;14002.229877356436;14081.788773168206;14110.647233818827;14360.138391696531;13931.930340348234;13936.303184840515;13965.720685586435;14437.494687686301;14732.189729564976;13847.515336963561;13956.302184890917;14001.299935003413;14310.71378572402;14816.185109819064;9503.144716975505;9546.713598592054;9588.952055239679;9707.417554946725;9759.512024398893;13196.076274660682;13594.86405135936;13819.170849749047;14169.787453188004;14400.711985760436 18:33:04 INFO - PROCESS | 3465 | |3;mootools.html;1530.8009958705366;1732.7054400751872;1780.4925596205085;1793.7399077133812;1807.3674214025084;6848.383645471907;7237.20390757017;7271.163816161136;7589.392848572114;7790.298873101419;7801.6489257983385;7853.6858525659045;7916.366690664748;7939.801504962379;7975.1227364989945;2284.6915666385075;2325.6395258734924;2326.441654003044;2331.895064722083;2335.311083230443;2310.503241803012;2338.2166974063707;2350.6239001759723;2353.564590550745;2359.8938047787806;2236.910523579055;2246.932592022242;2264.399934017487;2266.3654176830432;2280.5324908393823;2261.9321420357414;2294.9196778112687;2297.104129389531;2299.1722979727283;2299.4481324482085;2181.4001149683804;2282.9086836526517;2284.6344584866342;2285.04028308111;2287.1308902617066;7652.311291983749;7711.730089446843;7753.069631644183;7760.767176984699;7799.49303295284;4651.674272832261;4753.096911586787;4755.310479980418;4775.403074615673;4799.2801079837955;3033.135556366447;3139.780215384924;3167.113208301679;3191.0745883693703;3207.903762887117;978.5596481583316;982.3123813330698;1001.3541265883537;1015.8679371681634;1028.0850043461326;10287.17702583799;10288.845667314996;10310.793784124351;10336.483175841178;10451.738706532322;3970.4242884781543;3996.3805610130476;4026.416169655384;4031.5162180537936;4177.770222637784;8414.789630259293;8431.536265505456;8491.957540212383;8494.787630309169;8506.404551681446;4534.478534968455;4574.6340292776495;4582.175208462509;4605.953940460619;4609.562091601292;4177.26897792885;4221.261279276115;4235.343521754133;4240.194363071007;4268.466441694788;3437.1407148212948;3437.346904088215;3439.6904278615043;3453.033150717803;3487.8256087196046;1017.2523195451338;1017.3641474078701;1020.7090979070929;1032.0350472308417;1033.8552602635637;970.9320347575602;1029.0532709906904;1111.9777604447866;1184.461070213051;1341.8993575481877;7030.437564994788;7103.2541583133025;7116.5018448709125;7139.92860071403;7153.964230178815;592.4460629311521;604.392585451627;606.2543072021439;615.7536985205953;763.4732034896015;5412.91880621791;5603.943960560424;5622.91565626516;5639.915401268984;5699.544036477072;9029.77425564366;9315;9404.90595094054;9411.670591529264;9426.481543515172;9098.317626178063;9136.223421009288;9202.585883635253;9219.723408297761;9251.121143491358;7205.423566114699;7250;7283;7353.6323183840595;7361.742339018108;6937.479689023243;6997.895031574429;7004.894926576208;7015.123109611299;7075.575465472089;8044.959775201087;8161.469504482189;8196.34429245647;8294.709685161231;8295.377846661646;8379.203975622306;8384.556807039791;8481.957590212009;8495.150484951455;8609.956950215208;6607.438367738796;6614.710131524306;6660.866782664417;6663.267040625624;6673.399394054559;6847.691853866688;7429.034225550644;7479.513831600929;7496.512726672749;7496.550206987598;6850.006749021264;6867.969804529361;6893.414059804973;7010.75462358815;7011.053507776385;6599.60402375859;6687.966560167168;6764.5603035802515;6920.065791118134;6956.130483689539;6633.867322653617;6824.658767061528;6840.555363901331;6858.039874417485;6874;6147;6314.305426403183;6341.49268058545;6345.079963405373;6349.523785715997;6507.6746162692625;6553.049807777941;6557.672116394257;6561.311062338385;6572.507061970467 18:33:04 INFO - PROCESS | 3465 | |4;prototype.html;321.61085087044677;324.06022534649526;335.5470115344286;337.4230066586138;341.51163835714925;6348.365163483661;6363.077353783704;6418.133551970488;6427.228732552095;6495.285518592963;6275.7489700411925;6315.210598675166;6337.778177763779;6344.365563443654;6352.396522330383;4807.471178170398;4809.1343558159515;4812.783424745895;4812.879678008043;4819.204831202847;4791.472937976837;4803.111424386482;4821.566059054684;4828.56542911138;4829.90340193196;4669.8832529186875;4734.100520901018;4751.40607424072;4762.309465127554;4767.404074490689;4710.670253082286;4746.406699162605;4758.405199350082;4760;4761.190597598382;4098.631123198897;4118.382242663594;4122.690798190148;4131;4143.067809742814;5904.763809447617;5973.790917317917;5993.7302821372705;5994.760209591611;6004.279486461609;5391.164369522691;5572.944270557324;5573.721313934287;5582.469665381782;5584.022796010682;6668.299828517985;6723.529352945296;6724.731010759564;6732.158480189976;6744.696488658022;4561.657875659339;4571.542845715435;4580.3358513015755;4584.312353147021;4599.241125214336;6785.694643740994;6894.758683446055;6951.930480695179;6992.405645520137;7013.649317534103;4681.859544213611;4724.881877953078;4732.834350797705;4733.911200423921;4750.548697873696;4790.952090479121;4793.161196790547;4794.304825800239;4798.5441383068555;4820.084184005028;5515.669059856422;5559.499645031886;5560.638558493685;5570.832875013756;5574.08027675429;6554.508411869129;6700.128983232149;6706.128203333536;6726;6782.864342713118;1650.7936507936508;1664.4257731082757;1683.0827199176479;1683.318256106279;1685.662867426495;1082.1991726122612;1095.5070218401752;1103.5034234594464;1104.7956128116325;1121.9943900280446;6281.780137695158;6311.589746666452;6363.268224154282;6375.394337537927;6377.202849643794;6848.315168483112;6907.13660792401;6917.619530925746;6918.204406493318;6928.792136235921;6296.307406185316;6335.556511044275;6355.142055822497;6359.904601430982;6371.267304260069;3783.5838057813617;3830.2913960916762;3839.424086387064;3847.2305538891774;3853.2100919311474;7208.56748595086;7217.278272172741;7218.855622887513;7219.314165154302;7256.383207427322;7099.574025558483;7247.782566523013;7262.782116536512;7279.67241474135;7295.781126566211;7147.2138064812825;7155.356017958305;7171.856562868714;7194.136703595602;7208.855822883618;7030.437564994686;7048.436125109876;7050.894236586353;7056.576605403692;7068;6720.823855825309;6918.584884906922;6942.757003505055;6995.79012629622;6997.230304666585;7147.356737893615;7169.605671688108;7171.247019062923;7205.927940720526;7217.7473788417155;4691.718496890061;4711.505291944297;4738.31294462308;4757.690750101232;4760.000399916056;6799.286074962058;6844.349786770249;6944.826379340557;7005.824854378681;7028.648567571703;6741.898871516833;6744.291849355944;6746.291639377795;6776.93223067763;6828.692708828214;6774.119364482783;6813.148356455443;6817.0456136141975;6831.28271531482;6836.418904393182;6574.205962465837;6615.801525954229;6671.566348187353;6695.698693558704;6706.195256569243;6832.726690932506;6838.623875686885;6840.692168852314;6852.314768523108;6871.793846184622;6613.603183808987;6653.401193892573;6668.099806526056;6669.733210671713;6674.499412543982 18:33:04 INFO - PROCESS | 3465 | |5;yui.html;733.7982054934889;748.3414595156262;757.4924800383742;789.8104454930816;813.8779183122531;15393.846061539381;15747.370105195792;15748.055116693007;15772.369105235806;15774.4478943237;14397.352119154637;14524.709505809904;14584.927075364634;14589;14607.415703371853;835.302522393802;836.3894357119322;848.0459483081534;849.163573879728;855.0679759062621;844.6156998565668;853.1809462915609;853.906070332263;854.2824027816632;855.1277696749312;874.3879284500844;878.7934835313728;879.8328317619664;882.1443200095897;885.1281487734608;871.9171678690515;872.1104473437059;874.5015341255487;875.1336177184573;875.9255463285629;640.6956695569613;644.9387308205713;645.909572659828;646.12127506591;647.6923461355865;13941.163530188222;13968.860311396958;13986.230757308344;13994.250718660167;14038.017338786289;11006.779864402668;11153.888461115366;11184.105271578335;11236.847329759761;11540.307581545134;9390;9471.194948429391;9515.952420237854;9532.809343813085;9603;3359.96640033599;3421.8973430797114;3435.381631306364;3446.1040129566495;3454.3436747017986;47735.52264477345;48018.51981480175;48045.279320810216;48233.75883120597;48780.51219487795;8605.190083305037;8681.522516261666;8735.606897689619;8750.781230469289;8811;17404.564885877953;17419;17453.7381939271;17462.738058929128;17503.38738144159;6859.691313890887;6862.622555759382;6931.930680693128;7061.399781018568;7092.361687448051;3724.7951362675312;3789.5452545694143;3841.1741475582326;3868.323043467382;3885.630865067814;2911.9854400728286;2960.5707172459875;2966.9109926702235;2967.2581854536365;2968.094731107033;512.6155383462403;533.6477924569843;534.7005676820993;548.6488647265753;555.5056000159861;602.9547783916224;606.9028955367208;618;622.9283632382244;706.862161878439;8394.916050839414;8528;8650.307975361957;8685.829672169613;8730.86903696445;546.4835730234889;684.2917580304361;696.2758730919888;715.6455262187345;732.7984804178893;3808.352580061396;3887.9028024299055;4125.23683118618;4163.854265100707;4301.247281725686;54621;57888.42111578915;58492;59201;59322.70338648279;47518.287225691645;48539.271910921365;48599.5140048595;50116;50236.497635023916;44833;47877.76061119672;48166.75916620465;48179;49177.75411122993;8657.134286571292;8709.433886797338;8963.417377870417;9010.504422256576;9072;35745.82127089348;35871.282574347846;36429.45355819612;36496;36937.07657308589;41022.79488602538;41638.37542436805;44414.3337849926;46714.766426167655;46834;10517.474126293808;10518.158547316349;10545.472726363805;10610.151187905103;10738.516766745672;11272.943635281772;11306.265092768943;11526;11710.590129345432;11716.94141529287;10980.396078215455;11018;11096.722581935515;11297.26567773092;11414.315141091562;10734.409607471664;10760.946195268974;10964.616238431616;11103.50034248477;11113.055390291916;10641.680749577525;10731.356118632906;10846.45767711627;11028.172887033345;11154.051905588116;9492.525373731147;9551;9832.820061592654;9867.309288349747;10195.7451063724;8926.553672316488;9054.94724764911;9262.72211833646;9558.85661715061;9829.606815727291 18:33:04 INFO - PROCESS | 3465 | __end_tp_report 18:33:04 INFO - PROCESS | 3465 | __start_cc_report 18:33:04 INFO - PROCESS | 3465 | _x_x_mozilla_cycle_collect,299 18:33:04 INFO - PROCESS | 3465 | __end_cc_report 18:33:04 INFO - PROCESS | 3465 | __startTimestamp1450751584290__endTimestamp 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | ------- Summary: start ------- 18:33:04 INFO - PROCESS | 3465 | Number of tests: 6 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | [#0] dojo.html Cycles:165 Average:5485.96 Median:5683.74 stddev:609.60 (10.7%) stddev-sans-first:584.65 18:33:04 INFO - PROCESS | 3465 | Values: 3206.5 3249.6 3278.8 3279.6 3305.5 5199.7 5466.6 5474.6 5485.5 5509.2 5397.7 5398.5 5402.7 5496.9 5540.1 4993.0 5042.5 5115.1 5127.6 5127.7 5042.9 5119.5 5151.7 5182.9 5202.9 4874.9 4952.9 4978.6 5062.1 5101.9 5010.6 5022.8 5037.3 5066.6 5099.6 4992.2 5009.1 5012.9 5021.7 5033.1 5155.8 5163.9 5205.5 5213.9 5257.5 5881.6 5939.7 5948.6 5954.6 5956.2 5843.4 5983.6 5989.3 5993.1 6005.9 5469.7 5505.3 5544.7 5548.6 5560.3 5958.5 6000.6 6014.5 6015.6 6018.6 5736.4 5847.0 5850.4 5865.4 5867.7 5954.3 5988.9 5994.1 6018.8 6050.3 5881.7 5902.7 5933.0 5937.1 5938.0 5798.9 5801.7 5805.7 5923.1 5932.0 4559.7 4584.4 4587.3 4589.1 4641.8 4057.9 4066.2 4071.1 4083.4 4110.8 5365.2 5442.4 5464.5 5568.6 5682.1 5969.1 5990.4 5999.7 6003.0 6031.8 5592.5 5594.3 5596.0 5598.3 5608.9 5020.6 5094.7 5124.9 5152.4 5205.2 6054.1 6080.1 6093.9 6096.8 6099.1 6017.7 6019.5 6021.8 6022.7 6029.2 5844.6 5875.7 5908.7 5936.4 5969.5 5881.4 5894.7 5909.6 5926.2 5936.0 5977.2 5977.8 5978.7 5978.8 5982.2 5453.7 5621.2 5639.6 5672.3 5753.2 5791.0 5795.6 5812.0 5815.7 5841.7 5679.7 5729.1 5737.4 5741.1 5743.7 5559.8 5625.6 5766.2 5807.4 5885.4 5683.7 5696.3 5699.3 5703.1 5731.7 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | [#1] ext.html Cycles:180 Average:46607.06 Median:33734.58 stddev:78094.14 (231.5%) stddev-sans-first:78236.68 18:33:04 INFO - PROCESS | 3465 | Values: 560.8 598.9 600.2 617.4 619.4 38159.0 38473.6 38630.0 38866.8 38910.8 44116.1 44140.3 44711.1 44787.3 44886.1 8794.0 8895.0 8965.9 8987.4 9011.5 8700.2 8712.8 8804.3 8834.2 8836.6 8769.5 8806.2 8848.0 8858.8 8915.1 8778.2 8824.5 8825.2 8828.8 8920.2 8682.8 8813.3 8813.9 8867.7 8872.4 39640.8 40479.2 40490.0 40493.6 40501.8 3325.5 3341.4 3344.5 3360.9 3481.3 29888.6 29930.9 30222.1 30358.0 31049.0 3875.5 3893.1 3900.7 3911.3 4039.8 271004.0 272129.6 272481.0 273816.0 273960.0 53612.5 54954.0 67891.3 69149.3 69606.3 60696.4 61355.4 61582.0 61656.7 61729.4 15233.5 15395.9 15537.5 15545.2 15571.0 11670.6 11791.6 11796.4 11867.2 11918.7 20571.2 20873.2 20911.7 20970.5 21014.5 7662.6 7841.8 7929.4 7989.4 7995.2 877.4 877.8 900.1 1072.6 1123.3 27547.2 27981.3 27982.9 28129.2 28378.4 1021.7 1024.7 1025.9 1030.1 1099.3 14725.8 14772.0 14897.5 14939.1 15004.7 316454.0 317823.0 319874.0 320151.0 322042.0 51784.0 51893.2 52033.2 52155.1 52166.5 1311.3 1326.5 1336.5 1346.6 1358.5 26003.5 27157.3 27246.4 27449.3 27557.7 45755.8 46231.0 46267.3 46280.3 46358.3 299732.0 301332.0 301513.0 302626.0 304189.0 32091.7 32362.5 32374.5 32409.0 32494.7 36884.8 37163.4 37338.6 37680.8 38408.8 32174.0 32553.2 32805.7 33062.2 33154.2 33054.0 33217.5 35123.0 36798.6 36842.8 33281.3 33688.8 33695.2 33774.0 33844.5 29077.4 30963.4 31382.0 31443.8 31491.5 23901.5 24017.8 24111.2 24213.5 24341.9 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | [#2] jquery.html Cycles:180 Average:28334.08 Median:366.54 stddev:82528.53 (22515.3%) stddev-sans-first:82733.32 18:33:04 INFO - PROCESS | 3465 | Values: 363.9 366.2 366.9 368.3 369.2 11715.6 12124.9 16464.4 17307.4 17941.4 17250.1 17503.2 17543.2 17608.7 17697.7 5983.9 6101.5 6125.0 6126.4 6153.0 5173.0 5998.0 6068.6 6068.9 6110.5 6051.0 6065.5 6084.6 6085.3 6092.0 6073.1 6090.2 6184.8 6408.7 6422.9 6116.2 6133.7 6176.7 6180.7 6396.1 21916.2 22189.0 22321.4 22439.1 22566.7 2065.3 2121.4 2228.4 2330.6 2459.1 13538.3 13694.9 13951.9 14151.3 14301.2 1861.7 1871.7 1941.5 1941.5 1990.0 67422.7 70413.3 70526.3 72008.0 72277.6 15366.9 15672.5 15690.5 15692.7 15705.8 12880.7 13176.9 13206.4 24544.6 24563.4 5918.3 6054.1 6885.7 7436.1 7490.2 7145.1 7154.7 7215.6 7216.0 7291.4 4516.2 4612.5 4615.2 4622.0 4646.7 1860.3 1873.8 1896.0 1902.3 1903.2 897.1 907.4 913.8 963.5 980.9 16327.8 16614.6 16698.6 16703.8 16836.0 910.3 925.8 946.9 960.5 966.4 9442.5 9720.2 9781.5 9791.1 9896.6 500559.0 503106.0 503865.0 506114.0 510696.0 74972.3 75702.0 76135.0 76352.6 78302.0 1062.0 1074.2 1075.8 1093.5 1116.4 14917.9 14920.2 15016.4 15231.3 15546.7 29567.0 32682.3 34144.0 34406.0 35209.6 44025.2 44591.0 44871.6 45257.1 47010.3 9272.6 9487.0 9607.3 9667.0 9738.0 11313.6 11387.2 11432.1 16615.3 16995.2 8287.7 14002.2 14081.8 14110.6 14360.1 13931.9 13936.3 13965.7 14437.5 14732.2 13847.5 13956.3 14001.3 14310.7 14816.2 9503.1 9546.7 9589.0 9707.4 9759.5 13196.1 13594.9 13819.2 14169.8 14400.7 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | [#3] mootools.html Cycles:180 Average:5347.41 Median:6428.60 stddev:2764.02 (43.0%) stddev-sans-first:2756.89 18:33:04 INFO - PROCESS | 3465 | Values: 1530.8 1732.7 1780.5 1793.7 1807.4 6848.4 7237.2 7271.2 7589.4 7790.3 7801.6 7853.7 7916.4 7939.8 7975.1 2284.7 2325.6 2326.4 2331.9 2335.3 2310.5 2338.2 2350.6 2353.6 2359.9 2236.9 2246.9 2264.4 2266.4 2280.5 2261.9 2294.9 2297.1 2299.2 2299.4 2181.4 2282.9 2284.6 2285.0 2287.1 7652.3 7711.7 7753.1 7760.8 7799.5 4651.7 4753.1 4755.3 4775.4 4799.3 3033.1 3139.8 3167.1 3191.1 3207.9 978.6 982.3 1001.4 1015.9 1028.1 10287.2 10288.8 10310.8 10336.5 10451.7 3970.4 3996.4 4026.4 4031.5 4177.8 8414.8 8431.5 8492.0 8494.8 8506.4 4534.5 4574.6 4582.2 4606.0 4609.6 4177.3 4221.3 4235.3 4240.2 4268.5 3437.1 3437.3 3439.7 3453.0 3487.8 1017.3 1017.4 1020.7 1032.0 1033.9 970.9 1029.1 1112.0 1184.5 1341.9 7030.4 7103.3 7116.5 7139.9 7154.0 592.4 604.4 606.3 615.8 763.5 5412.9 5603.9 5622.9 5639.9 5699.5 9029.8 9315.0 9404.9 9411.7 9426.5 9098.3 9136.2 9202.6 9219.7 9251.1 7205.4 7250.0 7283.0 7353.6 7361.7 6937.5 6997.9 7004.9 7015.1 7075.6 8045.0 8161.5 8196.3 8294.7 8295.4 8379.2 8384.6 8482.0 8495.2 8610.0 6607.4 6614.7 6660.9 6663.3 6673.4 6847.7 7429.0 7479.5 7496.5 7496.6 6850.0 6868.0 6893.4 7010.8 7011.1 6599.6 6688.0 6764.6 6920.1 6956.1 6633.9 6824.7 6840.6 6858.0 6874.0 6147.0 6314.3 6341.5 6345.1 6349.5 6507.7 6553.0 6557.7 6561.3 6572.5 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | [#4] prototype.html Cycles:180 Average:5616.43 Median:6357.52 stddev:1716.92 (27.0%) stddev-sans-first:1675.11 18:33:04 INFO - PROCESS | 3465 | Values: 321.6 324.1 335.5 337.4 341.5 6348.4 6363.1 6418.1 6427.2 6495.3 6275.7 6315.2 6337.8 6344.4 6352.4 4807.5 4809.1 4812.8 4812.9 4819.2 4791.5 4803.1 4821.6 4828.6 4829.9 4669.9 4734.1 4751.4 4762.3 4767.4 4710.7 4746.4 4758.4 4760.0 4761.2 4098.6 4118.4 4122.7 4131.0 4143.1 5904.8 5973.8 5993.7 5994.8 6004.3 5391.2 5572.9 5573.7 5582.5 5584.0 6668.3 6723.5 6724.7 6732.2 6744.7 4561.7 4571.5 4580.3 4584.3 4599.2 6785.7 6894.8 6951.9 6992.4 7013.6 4681.9 4724.9 4732.8 4733.9 4750.5 4791.0 4793.2 4794.3 4798.5 4820.1 5515.7 5559.5 5560.6 5570.8 5574.1 6554.5 6700.1 6706.1 6726.0 6782.9 1650.8 1664.4 1683.1 1683.3 1685.7 1082.2 1095.5 1103.5 1104.8 1122.0 6281.8 6311.6 6363.3 6375.4 6377.2 6848.3 6907.1 6917.6 6918.2 6928.8 6296.3 6335.6 6355.1 6359.9 6371.3 3783.6 3830.3 3839.4 3847.2 3853.2 7208.6 7217.3 7218.9 7219.3 7256.4 7099.6 7247.8 7262.8 7279.7 7295.8 7147.2 7155.4 7171.9 7194.1 7208.9 7030.4 7048.4 7050.9 7056.6 7068.0 6720.8 6918.6 6942.8 6995.8 6997.2 7147.4 7169.6 7171.2 7205.9 7217.7 4691.7 4711.5 4738.3 4757.7 4760.0 6799.3 6844.3 6944.8 7005.8 7028.6 6741.9 6744.3 6746.3 6776.9 6828.7 6774.1 6813.1 6817.0 6831.3 6836.4 6574.2 6615.8 6671.6 6695.7 6706.2 6832.7 6838.6 6840.7 6852.3 6871.8 6613.6 6653.4 6668.1 6669.7 6674.5 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - PROCESS | 3465 | [#5] yui.html Cycles:180 Average:13717.65 Median:48569.39 stddev:15982.47 (32.9%) stddev-sans-first:15997.57 18:33:04 INFO - PROCESS | 3465 | Values: 733.8 748.3 757.5 789.8 813.9 15393.8 15747.4 15748.1 15772.4 15774.4 14397.4 14524.7 14584.9 14589.0 14607.4 835.3 836.4 848.0 849.2 855.1 844.6 853.2 853.9 854.3 855.1 874.4 878.8 879.8 882.1 885.1 871.9 872.1 874.5 875.1 875.9 640.7 644.9 645.9 646.1 647.7 13941.2 13968.9 13986.2 13994.3 14038.0 11006.8 11153.9 11184.1 11236.8 11540.3 9390.0 9471.2 9516.0 9532.8 9603.0 3360.0 3421.9 3435.4 3446.1 3454.3 47735.5 48018.5 48045.3 48233.8 48780.5 8605.2 8681.5 8735.6 8750.8 8811.0 17404.6 17419.0 17453.7 17462.7 17503.4 6859.7 6862.6 6931.9 7061.4 7092.4 3724.8 3789.5 3841.2 3868.3 3885.6 2912.0 2960.6 2966.9 2967.3 2968.1 512.6 533.6 534.7 548.6 555.5 603.0 606.9 618.0 622.9 706.9 8394.9 8528.0 8650.3 8685.8 8730.9 546.5 684.3 696.3 715.6 732.8 3808.4 3887.9 4125.2 4163.9 4301.2 54621.0 57888.4 58492.0 59201.0 59322.7 47518.3 48539.3 48599.5 50116.0 50236.5 44833.0 47877.8 48166.8 48179.0 49177.8 8657.1 8709.4 8963.4 9010.5 9072.0 35745.8 35871.3 36429.5 36496.0 36937.1 41022.8 41638.4 44414.3 46714.8 46834.0 10517.5 10518.2 10545.5 10610.2 10738.5 11272.9 11306.3 11526.0 11710.6 11716.9 10980.4 11018.0 11096.7 11297.3 11414.3 10734.4 10760.9 10964.6 11103.5 11113.1 10641.7 10731.4 10846.5 11028.2 11154.1 9492.5 9551.0 9832.8 9867.3 10195.7 8926.6 9054.9 9262.7 9558.9 9829.6 18:33:04 INFO - PROCESS | 3465 | -------- Summary: end -------- 18:33:04 INFO - PROCESS | 3465 | 18:33:04 INFO - TEST-INFO | 3465: exit 0 18:33:05 INFO - TEST-OK | dromaeo_css | took 1112903ms 18:33:05 INFO - TEST-START | kraken 18:33:05 INFO - operating with platform_type : linux_ 18:33:05 INFO - Initialising browser for kraken test... 18:33:05 INFO - TEST-INFO | started process 3710 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptD02dC/profile http://localhost:35782/getInfo.html) 18:33:08 INFO - PROCESS | 3710 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 18:33:09 INFO - PROCESS | 3710 | __metrics Screen width/height:1600/1200 18:33:09 INFO - PROCESS | 3710 | colorDepth:24 18:33:09 INFO - PROCESS | 3710 | Browser inner width/height: 1024/697 18:33:09 INFO - PROCESS | 3710 | __metrics 18:33:09 INFO - PROCESS | 3710 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:33:10 INFO - TEST-INFO | 3710: exit 0 18:33:10 INFO - Browser initialized. 18:33:10 INFO - Running cycle 1/1 for kraken test... 18:33:10 INFO - TEST-INFO | started process 3831 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptD02dC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:33:22 INFO - PROCESS | 3831 | RSS: Main: 151523328 18:33:22 INFO - PROCESS | 3831 | 18:33:24 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35782/tests/kraken/driver.html?testName=audio-beat-detection) 18:33:25 INFO - PROCESS | 3831 | RSS: Main: 152174592 18:33:25 INFO - PROCESS | 3831 | 18:33:28 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35782/tests/kraken/driver.html?testName=audio-dft) 18:33:28 INFO - PROCESS | 3831 | RSS: Main: 152236032 18:33:28 INFO - PROCESS | 3831 | 18:33:31 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35782/tests/kraken/driver.html?testName=audio-fft) 18:33:32 INFO - PROCESS | 3831 | RSS: Main: 147148800 18:33:32 INFO - PROCESS | 3831 | 18:33:34 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35782/tests/kraken/driver.html?testName=audio-oscillator) 18:33:34 INFO - PROCESS | 3831 | RSS: Main: 146833408 18:33:34 INFO - PROCESS | 3831 | 18:33:36 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:33:37 INFO - PROCESS | 3831 | RSS: Main: 148774912 18:33:37 INFO - PROCESS | 3831 | 18:33:40 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35782/tests/kraken/driver.html?testName=imaging-darkroom) 18:33:41 INFO - PROCESS | 3831 | RSS: Main: 148959232 18:33:41 INFO - PROCESS | 3831 | 18:33:44 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35782/tests/kraken/driver.html?testName=imaging-desaturate) 18:33:45 INFO - PROCESS | 3831 | RSS: Main: 149213184 18:33:45 INFO - PROCESS | 3831 | 18:33:47 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35782/tests/kraken/driver.html?testName=json-parse-financial) 18:33:48 INFO - PROCESS | 3831 | RSS: Main: 149692416 18:33:48 INFO - PROCESS | 3831 | 18:33:50 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:33:50 INFO - PROCESS | 3831 | RSS: Main: 149966848 18:33:50 INFO - PROCESS | 3831 | 18:33:52 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:33:53 INFO - PROCESS | 3831 | RSS: Main: 149831680 18:33:53 INFO - PROCESS | 3831 | 18:33:55 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:33:55 INFO - PROCESS | 3831 | RSS: Main: 149868544 18:33:55 INFO - PROCESS | 3831 | 18:33:58 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:33:59 INFO - PROCESS | 3831 | RSS: Main: 150401024 18:33:59 INFO - PROCESS | 3831 | 18:34:01 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:34:02 INFO - PROCESS | 3831 | RSS: Main: 149446656 18:34:02 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | Cycle 1(1): loaded http://localhost:35782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35782/tests/kraken/driver.html?testName=ai-astar) 18:34:04 INFO - PROCESS | 3831 | RSS: Main: 149463040 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | __start_tp_report 18:34:04 INFO - PROCESS | 3831 | _x_x_mozilla_page_load 18:34:04 INFO - PROCESS | 3831 | _x_x_mozilla_page_load_details 18:34:04 INFO - PROCESS | 3831 | |i|pagename|runs| 18:34:04 INFO - PROCESS | 3831 | |0;ai-astar;110;106;111;109;111;120;111;111;110;111 18:34:04 INFO - PROCESS | 3831 | |1;audio-beat-detection;155;124;149;162;127;152;160;131;161;132 18:34:04 INFO - PROCESS | 3831 | |2;audio-dft;161;161;163;163;163;161;163;163;169;164 18:34:04 INFO - PROCESS | 3831 | |3;audio-fft;72;71;72;72;74;72;148;71;72;72 18:34:04 INFO - PROCESS | 3831 | |4;audio-oscillator;94;95;134;94;94;93;138;94;94;129 18:34:04 INFO - PROCESS | 3831 | |5;imaging-gaussian-blur;109;111;109;109;110;109;110;109;110;110 18:34:04 INFO - PROCESS | 3831 | |6;imaging-darkroom;147;147;147;148;146;147;146;150;147;148 18:34:04 INFO - PROCESS | 3831 | |7;imaging-desaturate;97;98;97;96;97;97;96;97;96;96 18:34:04 INFO - PROCESS | 3831 | |8;json-parse-financial;61;62;60;59;61;61;62;61;58;63 18:34:04 INFO - PROCESS | 3831 | |9;json-stringify-tinderbox;67;68;68;68;68;68;67;69;68;67 18:34:04 INFO - PROCESS | 3831 | |10;stanford-crypto-aes;91;85;85;86;85;86;86;87;85;85 18:34:04 INFO - PROCESS | 3831 | |11;stanford-crypto-ccm;119;122;122;128;120;124;127;130;118;116 18:34:04 INFO - PROCESS | 3831 | |12;stanford-crypto-pbkdf2;143;155;156;154;164;145;155;150;161;154 18:34:04 INFO - PROCESS | 3831 | |13;stanford-crypto-sha256-iterative;69;68;71;68;69;68;68;67;69;70 18:34:04 INFO - PROCESS | 3831 | __end_tp_report 18:34:04 INFO - PROCESS | 3831 | __start_cc_report 18:34:04 INFO - PROCESS | 3831 | _x_x_mozilla_cycle_collect,694 18:34:04 INFO - PROCESS | 3831 | __end_cc_report 18:34:04 INFO - PROCESS | 3831 | __startTimestamp1450751644295__endTimestamp 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | ------- Summary: start ------- 18:34:04 INFO - PROCESS | 3831 | Number of tests: 14 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:3.53 (3.2%) stddev-sans-first:3.72 18:34:04 INFO - PROCESS | 3831 | Values: 110.0 106.0 111.0 109.0 111.0 120.0 111.0 111.0 110.0 111.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:153.50 stddev:15.14 (9.9%) stddev-sans-first:15.65 18:34:04 INFO - PROCESS | 3831 | Values: 155.0 124.0 149.0 162.0 127.0 152.0 160.0 131.0 161.0 132.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.33 (1.4%) stddev-sans-first:2.35 18:34:04 INFO - PROCESS | 3831 | Values: 161.0 161.0 163.0 163.0 163.0 161.0 163.0 163.0 169.0 164.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#3] audio-fft Cycles:10 Average:79.60 Median:72.00 stddev:24.05 (33.4%) stddev-sans-first:25.35 18:34:04 INFO - PROCESS | 3831 | Values: 72.0 71.0 72.0 72.0 74.0 72.0 148.0 71.0 72.0 72.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:19.28 (20.5%) stddev-sans-first:19.97 18:34:04 INFO - PROCESS | 3831 | Values: 94.0 95.0 134.0 94.0 94.0 93.0 138.0 94.0 94.0 129.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 18:34:04 INFO - PROCESS | 3831 | Values: 109.0 111.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 18:34:04 INFO - PROCESS | 3831 | Values: 147.0 147.0 147.0 148.0 146.0 147.0 146.0 150.0 147.0 148.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:34:04 INFO - PROCESS | 3831 | Values: 97.0 98.0 97.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:61.00 stddev:1.48 (2.4%) stddev-sans-first:1.56 18:34:04 INFO - PROCESS | 3831 | Values: 61.0 62.0 60.0 59.0 61.0 61.0 62.0 61.0 58.0 63.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 18:34:04 INFO - PROCESS | 3831 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 67.0 69.0 68.0 67.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.85 (2.2%) stddev-sans-first:0.73 18:34:04 INFO - PROCESS | 3831 | Values: 91.0 85.0 85.0 86.0 85.0 86.0 86.0 87.0 85.0 85.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.00 stddev:4.60 (3.7%) stddev-sans-first:4.69 18:34:04 INFO - PROCESS | 3831 | Values: 119.0 122.0 122.0 128.0 120.0 124.0 127.0 130.0 118.0 116.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:155.00 stddev:6.43 (4.1%) stddev-sans-first:5.53 18:34:04 INFO - PROCESS | 3831 | Values: 143.0 155.0 156.0 154.0 164.0 145.0 155.0 150.0 161.0 154.0 18:34:04 INFO - PROCESS | 3831 | 18:34:04 INFO - PROCESS | 3831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 18:34:04 INFO - PROCESS | 3831 | Values: 69.0 68.0 71.0 68.0 69.0 68.0 68.0 67.0 69.0 70.0 18:34:04 INFO - PROCESS | 3831 | -------- Summary: end -------- 18:34:04 INFO - PROCESS | 3831 | 18:34:05 INFO - TEST-INFO | 3831: exit 0 18:34:05 INFO - TEST-OK | kraken | took 60194ms 18:34:05 INFO - TEST-START | v8_7 18:34:05 INFO - operating with platform_type : linux_ 18:34:05 INFO - Initialising browser for v8_7 test... 18:34:05 INFO - TEST-INFO | started process 4118 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGVGkst/profile http://localhost:35782/getInfo.html) 18:34:08 INFO - PROCESS | 4118 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 18:34:09 INFO - PROCESS | 4118 | __metrics Screen width/height:1600/1200 18:34:09 INFO - PROCESS | 4118 | colorDepth:24 18:34:09 INFO - PROCESS | 4118 | Browser inner width/height: 1024/697 18:34:09 INFO - PROCESS | 4118 | __metrics 18:34:09 INFO - PROCESS | 4118 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:34:10 INFO - TEST-INFO | 4118: exit 0 18:34:10 INFO - Browser initialized. 18:34:10 INFO - Running cycle 1/1 for v8_7 test... 18:34:10 INFO - TEST-INFO | started process 4243 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGVGkst/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:22 INFO - PROCESS | 4243 | RSS: Main: 151040000 18:34:22 INFO - PROCESS | 4243 | 18:34:43 INFO - PROCESS | 4243 | Cycle 1(1): loaded http://localhost:35782/tests/v8_7/run.html (next: http://localhost:35782/tests/v8_7/run.html) 18:34:44 INFO - PROCESS | 4243 | RSS: Main: 146644992 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | __start_tp_report 18:34:44 INFO - PROCESS | 4243 | _x_x_mozilla_page_load 18:34:44 INFO - PROCESS | 4243 | _x_x_mozilla_page_load_details 18:34:44 INFO - PROCESS | 4243 | |i|pagename|runs| 18:34:44 INFO - PROCESS | 4243 | |0;Richards;166.9449081803005 18:34:44 INFO - PROCESS | 4243 | |1;DeltaBlue;187.72292096865027 18:34:44 INFO - PROCESS | 4243 | |2;Encrypt;279.79854504756577 18:34:44 INFO - PROCESS | 4243 | |3;Decrypt;5186.5284974093265 18:34:44 INFO - PROCESS | 4243 | |4;RayTrace;1062.6992561105208 18:34:44 INFO - PROCESS | 4243 | |5;Earley;743.4944237918215 18:34:44 INFO - PROCESS | 4243 | |6;Boyer;11882.35294117647 18:34:44 INFO - PROCESS | 4243 | |7;RegExp;25641.02564102564 18:34:44 INFO - PROCESS | 4243 | |8;Splay;662.0370370370371 18:34:44 INFO - PROCESS | 4243 | |9;NavierStokes;4850.241545893719 18:34:44 INFO - PROCESS | 4243 | __end_tp_report 18:34:44 INFO - PROCESS | 4243 | __startTimestamp1450751684114__endTimestamp 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | ------- Summary: start ------- 18:34:44 INFO - PROCESS | 4243 | Number of tests: 10 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 166.9 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 187.7 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 279.8 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 5186.5 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 1062.7 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#5] Earley Cycles:1 Average:743.49 Median:743.49 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 743.5 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#6] Boyer Cycles:1 Average:11882.35 Median:11882.35 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 11882.4 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 25641.0 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#8] Splay Cycles:1 Average:662.04 Median:662.04 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 662.0 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - PROCESS | 4243 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 18:34:44 INFO - PROCESS | 4243 | Values: 4850.2 18:34:44 INFO - PROCESS | 4243 | -------- Summary: end -------- 18:34:44 INFO - PROCESS | 4243 | 18:34:44 INFO - TEST-INFO | 4243: exit 0 18:34:44 INFO - TEST-OK | v8_7 | took 39764ms 18:34:44 INFO - SUITE-END | took 1212s 18:34:45 INFO - Completed test suite (00:20:13) 18:34:45 INFO - Working with test: dromaeo_css 18:34:45 INFO - Generating results file: dromaeo_css 18:34:45 INFO - Working with test: kraken 18:34:45 INFO - Generating results file: kraken 18:34:45 INFO - javascript benchmark 18:34:45 INFO - Working with test: v8_7 18:34:45 INFO - Generating results file: v8_7 18:34:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:34:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 18:34:45 INFO - process_Request line: dromaeo_css 7088.60 graph.html#tests=[[72,64,43]] 18:34:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:34:45 INFO - process_Request line: kraken 1518.20 graph.html#tests=[[232,64,43]] 18:34:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:34:45 INFO - process_Request line: v8_7 21128.57 graph.html#tests=[[230,64,43]] 18:34:45 INFO - RETURN: dromaeo_css: 7088.60 18:34:45 INFO - RETURN: kraken: 1518.20 18:34:45 INFO - RETURN: v8_7: 21128.57 18:34:45 INFO - javascript benchmark 18:34:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3206.470932296171, 3249.6425393206728, 3278.819664918429, 3279.573655424794, 3305.487649414342, 5199.740012999354, 5466.617336786427, 5474.589405794562, 5485.451454854512, 5509.173623956409, 5397.676139431627, 5398.541124004454, 5402.6758394496355, 5496.890062198763, 5540.085885828834, 4992.9750351248285, 5042.520960508764, 5115.053715062707, 5127.615428842833, 5127.692338459686, 5042.899142017158, 5119.5136462036235, 5151.6908985460805, 5182.870428239286, 5202.895942081156, 4874.8537543873745, 4952.925706114411, 4978.6017118630425, 5062.0888240116765, 5101.897962040757, 5010.649254552182, 5022.84931452057, 5037.319961805146, 5066.620003499752, 5099.59203263738, 4992.201247800371, 5009.123403404426, 5012.8997420051755, 5021.72380519075, 5033.0688822567945, 5155.84532464023, 5163.922541161885, 5205.479452054802, 5213.895722085575, 5257.526822585947, 5881.558883083786, 5939.67331796751, 5948.553858460589, 5954.642721436684, 5956.16613674086, 5843.386444423317, 5983.58114931955, 5989.2812862456785, 5993.0710739835395, 6005.909911351333, 5469.726513674301, 5505.256790333294, 5544.667319960815, 5548.639338442988, 5560.277163968658, 5958.493528050078, 6000.579959402888, 6014.548908831767, 6015.608985415934, 6018.638881667026, 5736.42635736423, 5846.970765146147, 5850.444207800252, 5865.35481097079, 5867.70661466925, 5954.285485741739, 5988.9101663475085, 5994.100884867305, 6018.8194354169445, 6050.304215015241, 5881.735321910524, 5902.704864756745, 5933.0, 5937.079752638348, 5938.020226662638, 5798.855028624318, 5801.738921748447, 5805.651660900359, 5923.111533270044, 5932.0, 4559.658025648089, 4584.358189853357, 4587.311903214478, 4589.128065667513, 4641.767911604406, 4057.9391309130388, 4066.1664358806374, 4071.145059537471, 4083.4079058536345, 4110.77390743512, 5365.248865158881, 5442.374126975369, 5464.535514481314, 5568.6101972862325, 5682.147677848356, 5969.134475501028, 5990.371011043865, 5999.730012149464, 6003.039513677878, 6031.819045428644, 5592.496675299161, 5594.272744543184, 5595.972020139955, 5598.3282006159525, 5608.859778505488, 5020.623453241022, 5094.719790411489, 5124.897502049938, 5152.355955505562, 5205.167173252262, 6054.122152287893, 6080.0879868019265, 6093.9390606093375, 6096.75612975476, 6099.085137229451, 6017.699115044143, 6019.458248757633, 6021.789237376846, 6022.668753218615, 6029.246344206974, 5844.620099693507, 5875.73559189846, 5908.7045647718305, 5936.406359364029, 5969.52243820502, 5881.411858814085, 5894.705264736832, 5909.5863289569315, 5926.2295901532525, 5936.0, 5977.193078934288, 5977.820665380045, 5978.730957106854, 5978.790742323998, 5982.162497250475, 5453.700046497481, 5621.213030175697, 5639.6334238274385, 5672.262605861211, 5753.223314852608, 5791.0, 5795.59430839854, 5812.0, 5815.651060936358, 5841.707914604338, 5679.6876171810945, 5729.054705973468, 5737.397573254748, 5741.081426971665, 5743.712814359182, 5559.833205003856, 5625.634333768292, 5766.163906233656, 5807.361190269152, 5885.3820348862755, 5683.7442315095095, 5696.259486266758, 5699.316082070012, 5703.087505999186, 5731.713414329351], "unit": "score", "name": "dojo.html", "value": 5446.21474116769}, {"lowerIsBetter": false, "replicates": [560.8107777456972, 598.8832177725343, 600.1567797244871, 617.3548641669455, 619.4394073363602, 38159.0, 38473.61526384735, 38629.99999999996, 38866.80566597167, 38910.80544597273, 44116.11767764643, 44140.3378949316, 44711.105777884426, 44787.328190077176, 44886.10227795442, 8793.999999999984, 8894.955525222365, 8965.910340896573, 8987.37088403812, 9011.504367259799, 8700.216980471756, 8712.782180445476, 8804.339674524404, 8834.160754728291, 8836.558172091402, 8769.473831570127, 8806.163414475615, 8848.026717061119, 8858.778530536723, 8915.108489151065, 8778.166074222938, 8824.514651694155, 8825.249853762438, 8828.823423531558, 8920.197182253596, 8682.826343473158, 8813.338999575057, 8813.867791983126, 8867.73396798097, 8872.423292486032, 39640.80179599083, 40479.19041619181, 40490.0, 40493.595064049274, 40501.79749101265, 3325.534425180477, 3341.4319565673895, 3344.464885618314, 3360.882369117069, 3481.3385456763385, 29888.551671724723, 29930.85034574813, 30222.09333719992, 30358.0, 31049.0, 3875.476810630557, 3893.10458594522, 3900.726949113563, 3911.2764138634443, 4039.818208180639, 271004.0, 272129.6393518039, 272481.0, 273816.0, 273960.0, 53612.46387536153, 54954.0, 67891.32108678948, 69149.30850691529, 69606.30393696099, 60696.39303606907, 61355.386446134966, 61582.0, 61656.69171654113, 61729.382706172364, 15233.466828661165, 15395.923020385051, 15537.45618903333, 15545.22273886301, 15571.0, 11670.649880503599, 11791.646250612495, 11796.410179490991, 11867.169298149047, 11918.702032449084, 20571.177152913715, 20873.1650733972, 20911.68632470514, 20970.475738106365, 21014.474638133863, 7662.61686915652, 7841.803954901059, 7929.405294602928, 7989.440739148204, 7995.240452157036, 877.3507604372846, 877.8376000439939, 900.0639335091562, 1072.6299426697776, 1123.2754873106965, 27547.173584792487, 27981.300467488476, 27982.86008569944, 28129.156125315865, 28378.43243135126, 1021.7394564386034, 1024.7335692719798, 1025.9230557708202, 1030.1346868630387, 1099.290957332516, 14725.779113313309, 14772.0, 14897.47858824936, 14939.103653780809, 15004.699906002037, 316454.0, 317823.0, 319874.0, 320151.0, 322042.0, 51784.0, 51893.22160167601, 52033.21950170751, 52155.088368372526, 52166.47833521692, 1311.2591385867145, 1326.476041963419, 1336.5322137251885, 1346.5690978886857, 1358.5448874626913, 26003.479930401663, 27157.321066973484, 27246.4173785257, 27449.31376715518, 27557.724422755517, 45755.77122114368, 46231.0, 46267.305990410845, 46280.30579541242, 46358.30462543132, 299732.0, 301332.0, 301513.0, 302626.0, 304189.0, 32091.67908320887, 32362.514562281114, 32374.514382284757, 32409.0, 32494.675053249164, 36884.81557592195, 37163.44254836126, 37338.62661373351, 37680.81159594184, 38408.807955960045, 32174.03477895667, 32553.186170345933, 32805.671943280264, 33062.17344566309, 33154.17114572155, 33054.0, 33217.50173747444, 35123.0, 36798.63201367952, 36842.8157859209, 33281.334373312886, 33688.831555842065, 33695.15762105967, 33774.0, 33844.492332614536, 29077.41845163127, 30963.380732385678, 31382.0, 31443.842780785948, 31491.527627085154, 23901.521969560858, 24017.759822401553, 24111.23824685367, 24213.51572968566, 24341.878290609144], "unit": "score", "name": "ext.html", "value": 18413.269605752143}, {"lowerIsBetter": false, "replicates": [363.94176931690936, 366.1578369749576, 366.9302832461832, 368.26163542098095, 369.20989083361593, 11715.589954351579, 12124.93937530311, 16464.423745168908, 17307.39424120156, 17941.372051978182, 17250.137493125356, 17503.212355444004, 17543.210555525002, 17608.735868961976, 17697.734533982002, 5983.910241346383, 6101.511879049687, 6125.0, 6126.417990290915, 6153.0155175171985, 5173.0, 5998.0, 6068.635881847081, 6068.878622427549, 6110.480609148228, 6051.0, 6065.545084118687, 6084.574079814415, 6085.330613632497, 6092.0, 6073.119397687333, 6090.23872015998, 6184.8144555663175, 6408.67956602168, 6422.935770642281, 6116.235470566179, 6133.6626485543275, 6176.69116544171, 6180.690965451709, 6396.072569477446, 21916.23293184747, 22189.001494932767, 22321.44196395087, 22439.102435902543, 22566.661500077513, 2065.297798748433, 2121.3847984084596, 2228.3760547046854, 2330.5804955108074, 2459.0655550890724, 13538.255395953218, 13694.863051369559, 13951.860481395157, 14151.29243537819, 14301.213433261166, 1861.6649003179423, 1871.709884967832, 1941.4563922101834, 1941.5243265400068, 1989.9900500497404, 67422.66288668575, 70413.29586704119, 70526.294737053, 72008.0, 72277.6386118066, 15366.923165384325, 15672.451464198699, 15690.450834220748, 15692.68614627701, 15705.764413533807, 12880.742385152245, 13176.868231317565, 13206.405711742995, 24544.631830522558, 24563.38591535226, 5918.2898052234, 6054.091886217103, 6885.724571017204, 7436.070491188601, 7490.176080631126, 7145.1425828900865, 7154.749583764543, 7215.639218039077, 7215.96392018047, 7291.416686665054, 4516.209663308908, 4612.469565999886, 4615.215413379734, 4621.953780462152, 4646.674732768742, 1860.3488778927538, 1873.8219869112413, 1895.9810401895804, 1902.267626963629, 1903.2196799312217, 897.1432282170512, 907.3512438606429, 913.7578541686458, 963.4556475591269, 980.9264305176997, 16327.83672163287, 16614.58463538397, 16698.58253543671, 16703.83296167023, 16836.0, 910.2717825739383, 925.7824411263348, 946.8674385586023, 960.4861399151421, 966.4008314844841, 9442.52787360643, 9720.222382209406, 9781.51092445389, 9791.118799308097, 9896.599721614606, 500559.0, 503106.0, 503865.0, 506114.0, 510696.0, 74972.25027749653, 75702.0, 76135.0, 76352.56413461408, 78302.0, 1062.0494657281845, 1074.215822449616, 1075.8063548561177, 1093.50245638236, 1116.4027245423658, 14917.925410372878, 14920.179390133648, 15016.399344026117, 15231.314590843216, 15546.689066218838, 29567.0, 32682.34635307328, 34144.0, 34406.0, 35209.647903520636, 44025.16978627659, 44591.0, 44871.55128448674, 45257.094858102, 47010.29484557803, 9272.629094836131, 9487.0, 9607.279454041114, 9667.0, 9738.0, 11313.604023859125, 11387.202895797545, 11432.14258930567, 16615.3353865844, 16995.23521441563, 8287.709930152416, 14002.229877356436, 14081.788773168206, 14110.647233818827, 14360.138391696531, 13931.930340348234, 13936.303184840515, 13965.720685586435, 14437.494687686301, 14732.189729564976, 13847.515336963561, 13956.302184890917, 14001.299935003413, 14310.71378572402, 14816.185109819064, 9503.144716975505, 9546.713598592054, 9588.952055239679, 9707.417554946725, 9759.512024398893, 13196.076274660682, 13594.86405135936, 13819.170849749047, 14169.787453188004, 14400.711985760436], "unit": "score", "name": "jquery.html", "value": 9225.661829021567}, {"lowerIsBetter": false, "replicates": [1530.8009958705366, 1732.7054400751872, 1780.4925596205085, 1793.7399077133812, 1807.3674214025084, 6848.383645471907, 7237.20390757017, 7271.163816161136, 7589.392848572114, 7790.298873101419, 7801.6489257983385, 7853.6858525659045, 7916.366690664748, 7939.801504962379, 7975.1227364989945, 2284.6915666385075, 2325.6395258734924, 2326.441654003044, 2331.895064722083, 2335.311083230443, 2310.503241803012, 2338.2166974063707, 2350.6239001759723, 2353.564590550745, 2359.8938047787806, 2236.910523579055, 2246.932592022242, 2264.399934017487, 2266.3654176830432, 2280.5324908393823, 2261.9321420357414, 2294.9196778112687, 2297.104129389531, 2299.1722979727283, 2299.4481324482085, 2181.4001149683804, 2282.9086836526517, 2284.6344584866342, 2285.04028308111, 2287.1308902617066, 7652.311291983749, 7711.730089446843, 7753.069631644183, 7760.767176984699, 7799.49303295284, 4651.674272832261, 4753.096911586787, 4755.310479980418, 4775.403074615673, 4799.2801079837955, 3033.135556366447, 3139.780215384924, 3167.113208301679, 3191.0745883693703, 3207.903762887117, 978.5596481583316, 982.3123813330698, 1001.3541265883537, 1015.8679371681634, 1028.0850043461326, 10287.17702583799, 10288.845667314996, 10310.793784124351, 10336.483175841178, 10451.738706532322, 3970.4242884781543, 3996.3805610130476, 4026.416169655384, 4031.5162180537936, 4177.770222637784, 8414.789630259293, 8431.536265505456, 8491.957540212383, 8494.787630309169, 8506.404551681446, 4534.478534968455, 4574.6340292776495, 4582.175208462509, 4605.953940460619, 4609.562091601292, 4177.26897792885, 4221.261279276115, 4235.343521754133, 4240.194363071007, 4268.466441694788, 3437.1407148212948, 3437.346904088215, 3439.6904278615043, 3453.033150717803, 3487.8256087196046, 1017.2523195451338, 1017.3641474078701, 1020.7090979070929, 1032.0350472308417, 1033.8552602635637, 970.9320347575602, 1029.0532709906904, 1111.9777604447866, 1184.461070213051, 1341.8993575481877, 7030.437564994788, 7103.2541583133025, 7116.5018448709125, 7139.92860071403, 7153.964230178815, 592.4460629311521, 604.392585451627, 606.2543072021439, 615.7536985205953, 763.4732034896015, 5412.91880621791, 5603.943960560424, 5622.91565626516, 5639.915401268984, 5699.544036477072, 9029.77425564366, 9315.0, 9404.90595094054, 9411.670591529264, 9426.481543515172, 9098.317626178063, 9136.223421009288, 9202.585883635253, 9219.723408297761, 9251.121143491358, 7205.423566114699, 7250.0, 7283.0, 7353.6323183840595, 7361.742339018108, 6937.479689023243, 6997.895031574429, 7004.894926576208, 7015.123109611299, 7075.575465472089, 8044.959775201087, 8161.469504482189, 8196.34429245647, 8294.709685161231, 8295.377846661646, 8379.203975622306, 8384.556807039791, 8481.957590212009, 8495.150484951455, 8609.956950215208, 6607.438367738796, 6614.710131524306, 6660.866782664417, 6663.267040625624, 6673.399394054559, 6847.691853866688, 7429.034225550644, 7479.513831600929, 7496.512726672749, 7496.550206987598, 6850.006749021264, 6867.969804529361, 6893.414059804973, 7010.75462358815, 7011.053507776385, 6599.60402375859, 6687.966560167168, 6764.5603035802515, 6920.065791118134, 6956.130483689539, 6633.867322653617, 6824.658767061528, 6840.555363901331, 6858.039874417485, 6874.0, 6147.0, 6314.305426403183, 6341.49268058545, 6345.079963405373, 6349.523785715997, 6507.6746162692625, 6553.049807777941, 6557.672116394257, 6561.311062338385, 6572.507061970467], "unit": "score", "name": "mootools.html", "value": 4354.3929182709135}, {"lowerIsBetter": false, "replicates": [321.61085087044677, 324.06022534649526, 335.5470115344286, 337.4230066586138, 341.51163835714925, 6348.365163483661, 6363.077353783704, 6418.133551970488, 6427.228732552095, 6495.285518592963, 6275.7489700411925, 6315.210598675166, 6337.778177763779, 6344.365563443654, 6352.396522330383, 4807.471178170398, 4809.1343558159515, 4812.783424745895, 4812.879678008043, 4819.204831202847, 4791.472937976837, 4803.111424386482, 4821.566059054684, 4828.56542911138, 4829.90340193196, 4669.8832529186875, 4734.100520901018, 4751.40607424072, 4762.309465127554, 4767.404074490689, 4710.670253082286, 4746.406699162605, 4758.405199350082, 4760.0, 4761.190597598382, 4098.631123198897, 4118.382242663594, 4122.690798190148, 4131.0, 4143.067809742814, 5904.763809447617, 5973.790917317917, 5993.7302821372705, 5994.760209591611, 6004.279486461609, 5391.164369522691, 5572.944270557324, 5573.721313934287, 5582.469665381782, 5584.022796010682, 6668.299828517985, 6723.529352945296, 6724.731010759564, 6732.158480189976, 6744.696488658022, 4561.657875659339, 4571.542845715435, 4580.3358513015755, 4584.312353147021, 4599.241125214336, 6785.694643740994, 6894.758683446055, 6951.930480695179, 6992.405645520137, 7013.649317534103, 4681.859544213611, 4724.881877953078, 4732.834350797705, 4733.911200423921, 4750.548697873696, 4790.952090479121, 4793.161196790547, 4794.304825800239, 4798.5441383068555, 4820.084184005028, 5515.669059856422, 5559.499645031886, 5560.638558493685, 5570.832875013756, 5574.08027675429, 6554.508411869129, 6700.128983232149, 6706.128203333536, 6726.0, 6782.864342713118, 1650.7936507936508, 1664.4257731082757, 1683.0827199176479, 1683.318256106279, 1685.662867426495, 1082.1991726122612, 1095.5070218401752, 1103.5034234594464, 1104.7956128116325, 1121.9943900280446, 6281.780137695158, 6311.589746666452, 6363.268224154282, 6375.394337537927, 6377.202849643794, 6848.315168483112, 6907.13660792401, 6917.619530925746, 6918.204406493318, 6928.792136235921, 6296.307406185316, 6335.556511044275, 6355.142055822497, 6359.904601430982, 6371.267304260069, 3783.5838057813617, 3830.2913960916762, 3839.424086387064, 3847.2305538891774, 3853.2100919311474, 7208.56748595086, 7217.278272172741, 7218.855622887513, 7219.314165154302, 7256.383207427322, 7099.574025558483, 7247.782566523013, 7262.782116536512, 7279.67241474135, 7295.781126566211, 7147.2138064812825, 7155.356017958305, 7171.856562868714, 7194.136703595602, 7208.855822883618, 7030.437564994686, 7048.436125109876, 7050.894236586353, 7056.576605403692, 7068.0, 6720.823855825309, 6918.584884906922, 6942.757003505055, 6995.79012629622, 6997.230304666585, 7147.356737893615, 7169.605671688108, 7171.247019062923, 7205.927940720526, 7217.7473788417155, 4691.718496890061, 4711.505291944297, 4738.31294462308, 4757.690750101232, 4760.000399916056, 6799.286074962058, 6844.349786770249, 6944.826379340557, 7005.824854378681, 7028.648567571703, 6741.898871516833, 6744.291849355944, 6746.291639377795, 6776.93223067763, 6828.692708828214, 6774.119364482783, 6813.148356455443, 6817.0456136141975, 6831.28271531482, 6836.418904393182, 6574.205962465837, 6615.801525954229, 6671.566348187353, 6695.698693558704, 6706.195256569243, 6832.726690932506, 6838.623875686885, 6840.692168852314, 6852.314768523108, 6871.793846184622, 6613.603183808987, 6653.401193892573, 6668.099806526056, 6669.733210671713, 6674.499412543982], "unit": "score", "name": "prototype.html", "value": 5046.998964394928}, {"lowerIsBetter": false, "replicates": [733.7982054934889, 748.3414595156262, 757.4924800383742, 789.8104454930816, 813.8779183122531, 15393.846061539381, 15747.370105195792, 15748.055116693007, 15772.369105235806, 15774.4478943237, 14397.352119154637, 14524.709505809904, 14584.927075364634, 14589.0, 14607.415703371853, 835.302522393802, 836.3894357119322, 848.0459483081534, 849.163573879728, 855.0679759062621, 844.6156998565668, 853.1809462915609, 853.906070332263, 854.2824027816632, 855.1277696749312, 874.3879284500844, 878.7934835313728, 879.8328317619664, 882.1443200095897, 885.1281487734608, 871.9171678690515, 872.1104473437059, 874.5015341255487, 875.1336177184573, 875.9255463285629, 640.6956695569613, 644.9387308205713, 645.909572659828, 646.12127506591, 647.6923461355865, 13941.163530188222, 13968.860311396958, 13986.230757308344, 13994.250718660167, 14038.017338786289, 11006.779864402668, 11153.888461115366, 11184.105271578335, 11236.847329759761, 11540.307581545134, 9390.0, 9471.194948429391, 9515.952420237854, 9532.809343813085, 9603.0, 3359.96640033599, 3421.8973430797114, 3435.381631306364, 3446.1040129566495, 3454.3436747017986, 47735.52264477345, 48018.51981480175, 48045.279320810216, 48233.75883120597, 48780.51219487795, 8605.190083305037, 8681.522516261666, 8735.606897689619, 8750.781230469289, 8811.0, 17404.564885877953, 17419.0, 17453.7381939271, 17462.738058929128, 17503.38738144159, 6859.691313890887, 6862.622555759382, 6931.930680693128, 7061.399781018568, 7092.361687448051, 3724.7951362675312, 3789.5452545694143, 3841.1741475582326, 3868.323043467382, 3885.630865067814, 2911.9854400728286, 2960.5707172459875, 2966.9109926702235, 2967.2581854536365, 2968.094731107033, 512.6155383462403, 533.6477924569843, 534.7005676820993, 548.6488647265753, 555.5056000159861, 602.9547783916224, 606.9028955367208, 618.0, 622.9283632382244, 706.862161878439, 8394.916050839414, 8528.0, 8650.307975361957, 8685.829672169613, 8730.86903696445, 546.4835730234889, 684.2917580304361, 696.2758730919888, 715.6455262187345, 732.7984804178893, 3808.352580061396, 3887.9028024299055, 4125.23683118618, 4163.854265100707, 4301.247281725686, 54621.0, 57888.42111578915, 58492.0, 59201.0, 59322.70338648279, 47518.287225691645, 48539.271910921365, 48599.5140048595, 50116.0, 50236.497635023916, 44833.0, 47877.76061119672, 48166.75916620465, 48179.0, 49177.75411122993, 8657.134286571292, 8709.433886797338, 8963.417377870417, 9010.504422256576, 9072.0, 35745.82127089348, 35871.282574347846, 36429.45355819612, 36496.0, 36937.07657308589, 41022.79488602538, 41638.37542436805, 44414.3337849926, 46714.766426167655, 46834.0, 10517.474126293808, 10518.158547316349, 10545.472726363805, 10610.151187905103, 10738.516766745672, 11272.943635281772, 11306.265092768943, 11526.0, 11710.590129345432, 11716.94141529287, 10980.396078215455, 11018.0, 11096.722581935515, 11297.26567773092, 11414.315141091562, 10734.409607471664, 10760.946195268974, 10964.616238431616, 11103.50034248477, 11113.055390291916, 10641.680749577525, 10731.356118632906, 10846.45767711627, 11028.172887033345, 11154.051905588116, 9492.525373731147, 9551.0, 9832.820061592654, 9867.309288349747, 10195.7451063724, 8926.553672316488, 9054.94724764911, 9262.72211833646, 9558.85661715061, 9829.606815727291], "unit": "score", "name": "yui.html", "value": 6239.395986734613}], "name": "dromaeo_css", "value": 7088.605299370364}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 109.0, 111.0, 120.0, 111.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 149.0, 162.0, 127.0, 152.0, 160.0, 131.0, 161.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 163.0, 163.0, 161.0, 163.0, 163.0, 169.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 72.0, 74.0, 72.0, 148.0, 71.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 134.0, 94.0, 94.0, 93.0, 138.0, 94.0, 94.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 150.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 60.0, 59.0, 61.0, 61.0, 62.0, 61.0, 58.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 60.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [91.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 87.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 122.0, 128.0, 120.0, 124.0, 127.0, 130.0, 118.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [143.0, 155.0, 156.0, 154.0, 164.0, 145.0, 155.0, 150.0, 161.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 71.0, 68.0, 69.0, 68.0, 68.0, 67.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1518.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [743.4944237918215], "unit": "score", "name": "Earley", "value": 896.3927350000001}, {"lowerIsBetter": false, "replicates": [11882.35294117647], "unit": "score", "name": "Boyer", "value": 56.08847029702973}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [662.0370370370371], "unit": "score", "name": "Splay", "value": 123.09130069930072}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21128.566506269606}]} 18:34:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21128.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1518.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7088.60"}}} 18:34:45 INFO - Return code: 0 18:34:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:34:45 INFO - # TBPL SUCCESS # 18:34:45 INFO - Running post-action listener: _resource_record_post_action 18:34:45 INFO - Running post-run listener: _resource_record_post_run 18:34:46 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10469376; Write bytes: 446369792; Read time: 2972; Write time: 542720 18:34:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 116408320; Read time: 0; Write time: 173952 18:34:46 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 8708096; Write bytes: 329961472; Read time: 2924; Write time: 368768 18:34:46 INFO - Running post-run listener: _upload_blobber_files 18:34:46 INFO - Blob upload gear active. 18:34:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 18:34:46 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 18:34:46 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'] 18:34:46 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 18:34:46 INFO - (blobuploader) - INFO - Open directory for files ... 18:34:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:34:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:34:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:47 INFO - (blobuploader) - INFO - Done attempting. 18:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:48 INFO - (blobuploader) - INFO - Done attempting. 18:34:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:34:48 INFO - Return code: 0 18:34:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 18:34:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 18:34:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa13abcf53849a392cf0ab9e05507509e450c826a99568c07d7a23f1cbff241f230ade15e92c127a59a640393fb46691141eb198be19fabbb78c7ed277ff1825", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207d26f4fb674dd3d9b358600f7c8f3a02dfb02c67552b5567f33ccdc77dc5f8f75487a9e1df207cf686ddd5350ba0b5146ba698d640504eafc791323b784e71"} 18:34:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 18:34:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 18:34:48 INFO - Contents: 18:34:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa13abcf53849a392cf0ab9e05507509e450c826a99568c07d7a23f1cbff241f230ade15e92c127a59a640393fb46691141eb198be19fabbb78c7ed277ff1825", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207d26f4fb674dd3d9b358600f7c8f3a02dfb02c67552b5567f33ccdc77dc5f8f75487a9e1df207cf686ddd5350ba0b5146ba698d640504eafc791323b784e71"} 18:34:48 INFO - Copying logs to upload dir... 18:34:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.332435 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-21 18:34:48.744194) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 18:34:48.747458) ========= 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=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa13abcf53849a392cf0ab9e05507509e450c826a99568c07d7a23f1cbff241f230ade15e92c127a59a640393fb46691141eb198be19fabbb78c7ed277ff1825", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207d26f4fb674dd3d9b358600f7c8f3a02dfb02c67552b5567f33ccdc77dc5f8f75487a9e1df207cf686ddd5350ba0b5146ba698d640504eafc791323b784e71"} build_url:https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/tIC-IfgvQdO9m83rxU0Nuw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa13abcf53849a392cf0ab9e05507509e450c826a99568c07d7a23f1cbff241f230ade15e92c127a59a640393fb46691141eb198be19fabbb78c7ed277ff1825", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207d26f4fb674dd3d9b358600f7c8f3a02dfb02c67552b5567f33ccdc77dc5f8f75487a9e1df207cf686ddd5350ba0b5146ba698d640504eafc791323b784e71"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 18:34:48.772365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:34:48.772684) ========= 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=7f67ac1ceef7774224e327f2000001f6-1450749133.40091-1436668260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:34:48.855808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 18:34:48.856136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 18:34:48.856436) ========= ========= Total master_lag: 0.51 =========