builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1451620831.66 results: success (0) buildid: 20151231173004 builduid: b7cb4c5930c44d42a0871f9ce26ac5a2 revision: 6786ccb1dba475cb92f0a69b8daf544d4213c8da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.655618) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.656114) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.656487) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006408 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.687025) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.687465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.703993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.704454) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.754729) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.755083) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.755585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.755903) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 20:00:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.0M=0s 2015-12-31 20:00:32 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.903728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.904056) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022467 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.954890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:31.955232) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6786ccb1dba475cb92f0a69b8daf544d4213c8da --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 6786ccb1dba475cb92f0a69b8daf544d4213c8da --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=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 20:00:32,847 truncating revision to first 12 chars 2015-12-31 20:00:32,847 Setting DEBUG logging. 2015-12-31 20:00:32,847 attempt 1/10 2015-12-31 20:00:32,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6786ccb1dba4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 20:00:33,105 unpacking tar archive at: fx-team-6786ccb1dba4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536482 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:32.504873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:32.505186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:32.516371) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:32.516693) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 20:00:32.517110) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-31 20:00:32.517412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:00:33 INFO - MultiFileLogger online at 20151231 20:00:33 in /builds/slave/test-pgo 20:00:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:00:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:00:33 INFO - {'append_to_log': False, 20:00:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:00:33 INFO - 'blob_upload_branch': 'Fx-Team', 20:00:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:00:33 INFO - 'branch': 'Fx-Team', 20:00:33 INFO - 'buildbot_json_path': 'buildprops.json', 20:00:33 INFO - 'config_files': ('talos/linux_config.py',), 20:00:33 INFO - 'default_actions': ('clobber', 20:00:33 INFO - 'read-buildbot-config', 20:00:33 INFO - 'download-and-extract', 20:00:33 INFO - 'populate-webroot', 20:00:33 INFO - 'create-virtualenv', 20:00:33 INFO - 'install', 20:00:33 INFO - 'run-tests'), 20:00:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:00:33 INFO - 'download_minidump_stackwalk': True, 20:00:33 INFO - 'download_symbols': 'ondemand', 20:00:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:00:33 INFO - 'tooltool.py': '/tools/tooltool.py', 20:00:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:00:33 INFO - '/tools/misc-python/virtualenv.py')}, 20:00:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:00:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:00:33 INFO - 'installer_path': 'installer.exe', 20:00:33 INFO - 'log_level': 'info', 20:00:33 INFO - 'log_name': 'talos', 20:00:33 INFO - 'log_to_console': True, 20:00:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:00:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:00:33 INFO - 'opt_config_files': (), 20:00:33 INFO - 'pip_index': False, 20:00:33 INFO - 'sps_profile': False, 20:00:33 INFO - 'sps_profile_interval': 0, 20:00:33 INFO - 'suite': 'dromaeojs', 20:00:33 INFO - 'system_bits': '32', 20:00:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:00:33 INFO - 'title': 'talos-linux64-ix-057', 20:00:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:00:33 INFO - 'use_talos_json': True, 20:00:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:00:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:00:33 INFO - 'work_dir': 'build'} 20:00:33 INFO - ##### 20:00:33 INFO - ##### Running clobber step. 20:00:33 INFO - ##### 20:00:33 INFO - Running pre-action listener: _resource_record_pre_action 20:00:33 INFO - Running main action method: clobber 20:00:33 INFO - rmtree: /builds/slave/test-pgo/build 20:00:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:00:33 INFO - Running post-action listener: _resource_record_post_action 20:00:33 INFO - ##### 20:00:33 INFO - ##### Running read-buildbot-config step. 20:00:33 INFO - ##### 20:00:33 INFO - Running pre-action listener: _resource_record_pre_action 20:00:33 INFO - Running main action method: read_buildbot_config 20:00:33 INFO - Using buildbot properties: 20:00:33 INFO - { 20:00:33 INFO - "project": "", 20:00:33 INFO - "product": "firefox", 20:00:33 INFO - "script_repo_revision": "production", 20:00:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:00:33 INFO - "repository": "", 20:00:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:00:33 INFO - "buildid": "20151231173004", 20:00:33 INFO - "pgo_build": "True", 20:00:33 INFO - "basedir": "/builds/slave/test-pgo", 20:00:33 INFO - "buildnumber": 394, 20:00:33 INFO - "slavename": "talos-linux64-ix-057", 20:00:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:00:33 INFO - "platform": "ubuntu64_hw", 20:00:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:00:33 INFO - "branch": "fx-team", 20:00:33 INFO - "repo_path": "integration/fx-team", 20:00:33 INFO - "revision": "6786ccb1dba475cb92f0a69b8daf544d4213c8da", 20:00:33 INFO - "stage_platform": "linux64-pgo", 20:00:33 INFO - "builduid": "b7cb4c5930c44d42a0871f9ce26ac5a2", 20:00:33 INFO - "slavebuilddir": "test" 20:00:33 INFO - } 20:00:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:00:33 INFO - Running post-action listener: _resource_record_post_action 20:00:33 INFO - ##### 20:00:33 INFO - ##### Running download-and-extract step. 20:00:33 INFO - ##### 20:00:33 INFO - Running pre-action listener: _resource_record_pre_action 20:00:33 INFO - Running main action method: download_and_extract 20:00:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:33 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json 20:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json 20:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:00:41 INFO - Downloaded 1302 bytes. 20:00:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:00:41 INFO - Using the following test package requirements: 20:00:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:00:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:41 INFO - u'jsshell-linux-x86_64.zip'], 20:00:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:00:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:00:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:00:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:00:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:00:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:41 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:47 INFO - Downloaded 23195603 bytes. 20:00:47 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 20:00:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:47 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 20:00:48 INFO - Return code: 0 20:00:48 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 20:00:48 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')]} 20:00:48 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:49 INFO - Downloaded 23195603 bytes. 20:00:49 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 20:00:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:00:49 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 20:00:50 INFO - Return code: 0 20:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:50 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:00:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:51 INFO - Downloaded 11132285 bytes. 20:00:51 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 20:00:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:51 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 20:00:52 INFO - Return code: 0 20:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:52 INFO - https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuJrATnRRUyHInGWFrqNEQ/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 20:00:53 INFO - Downloaded 54943697 bytes. 20:00:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:53 INFO - mkdir: /builds/slave/test-pgo/properties 20:00:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:00:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:00:53 INFO - Contents: 20:00:53 INFO - build_url:https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:00:53 INFO - Running post-action listener: _resource_record_post_action 20:00:53 INFO - Running post-action listener: set_extra_try_arguments 20:00:53 INFO - ##### 20:00:53 INFO - ##### Running populate-webroot step. 20:00:53 INFO - ##### 20:00:53 INFO - Running pre-action listener: _resource_record_pre_action 20:00:53 INFO - Running main action method: populate_webroot 20:00:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:00:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:00:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:00:53 INFO - '--tppagecycles', 20:00:53 INFO - '7'], 20:00:53 INFO - 'tests': ['tsvgm']}}, 20:00:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:00:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:00:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:00:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:00:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'tests': ['damp', 'tps']}, 20:00:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['damp', 'tps']}, 20:00:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:00:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:00:53 INFO - 'other': {'tests': ['a11yr', 20:00:53 INFO - 'ts_paint', 20:00:53 INFO - 'tpaint', 20:00:53 INFO - 'sessionrestore', 20:00:53 INFO - 'sessionrestore_no_auto_restore']}, 20:00:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['a11yr', 20:00:53 INFO - 'ts_paint', 20:00:53 INFO - 'tpaint', 20:00:53 INFO - 'sessionrestore', 20:00:53 INFO - 'sessionrestore_no_auto_restore']}, 20:00:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['a11yr', 20:00:53 INFO - 'ts_paint', 20:00:53 INFO - 'tpaint', 20:00:53 INFO - 'sessionrestore', 20:00:53 INFO - 'sessionrestore_no_auto_restore']}, 20:00:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['a11yr', 20:00:53 INFO - 'ts_paint', 20:00:53 INFO - 'tpaint', 20:00:53 INFO - 'sessionrestore', 20:00:53 INFO - 'sessionrestore_no_auto_restore']}, 20:00:53 INFO - 'other_l64': {'tests': ['a11yr', 20:00:53 INFO - 'ts_paint', 20:00:53 INFO - 'tpaint', 20:00:53 INFO - 'sessionrestore', 20:00:53 INFO - 'sessionrestore_no_auto_restore']}, 20:00:53 INFO - 'other_nol64': {'tests': ['a11yr', 20:00:53 INFO - 'ts_paint', 20:00:53 INFO - 'tpaint', 20:00:53 INFO - 'sessionrestore', 20:00:53 INFO - 'sessionrestore_no_auto_restore']}, 20:00:53 INFO - 'svgr': {'tests': ['tsvgx', 20:00:53 INFO - 'tsvgr_opacity', 20:00:53 INFO - 'tart', 20:00:53 INFO - 'tscrollx', 20:00:53 INFO - 'cart']}, 20:00:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['tsvgx', 20:00:53 INFO - 'tsvgr_opacity', 20:00:53 INFO - 'tart', 20:00:53 INFO - 'tscrollx', 20:00:53 INFO - 'cart']}, 20:00:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'tests': ['tp5o']}, 20:00:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'talos_options': ['--e10s'], 20:00:53 INFO - 'tests': ['tp5o']}, 20:00:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'talos_options': ['--xperf_path', 20:00:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:53 INFO - 'tests': ['tp5n']}, 20:00:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:53 INFO - 'talos_options': ['--e10s', 20:00:53 INFO - '--xperf_path', 20:00:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:53 INFO - 'tests': ['tp5n']}}, 20:00:53 INFO - 'talos.zip': {'path': '', 20:00:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:00:53 INFO - Running post-action listener: _resource_record_post_action 20:00:53 INFO - ##### 20:00:53 INFO - ##### Running create-virtualenv step. 20:00:53 INFO - ##### 20:00:53 INFO - Running pre-action listener: _resource_record_pre_action 20:00:53 INFO - Running main action method: create_virtualenv 20:00:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:00:53 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 20:00:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:00:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:00:53 INFO - Using real prefix '/usr' 20:00:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:00:54 INFO - Installing distribute.............................................................................................................................................................................................done. 20:00:55 INFO - Installing pip.................done. 20:00:55 INFO - Return code: 0 20:00:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:55 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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:00:55 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 20:00:55 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 20:00:55 INFO - Using env: {'DISPLAY': ':0', 20:00:55 INFO - 'HOME': '/home/cltbld', 20:00:55 INFO - 'LANG': 'en_US.UTF-8', 20:00:55 INFO - 'LANGUAGE': 'en_US:en', 20:00:55 INFO - 'LOGNAME': 'cltbld', 20:00:55 INFO - 'MAIL': '/var/mail/cltbld', 20:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:55 INFO - 'MOZ_NO_REMOTE': '1', 20:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:55 INFO - 'NO_EM_RESTART': '1', 20:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:55 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:55 INFO - 'SHELL': '/bin/bash', 20:00:55 INFO - 'SHLVL': '1', 20:00:55 INFO - 'TERM': 'linux', 20:00:55 INFO - 'TMOUT': '86400', 20:00:55 INFO - 'USER': 'cltbld', 20:00:55 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:55 INFO - '_': '/tools/buildbot/bin/python'} 20:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:56 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 20:00:56 INFO - Cleaning up... 20:00:56 INFO - Return code: 0 20:00:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 20:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --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 20:00:56 INFO - Using env: {'DISPLAY': ':0', 20:00:56 INFO - 'HOME': '/home/cltbld', 20:00:56 INFO - 'LANG': 'en_US.UTF-8', 20:00:56 INFO - 'LANGUAGE': 'en_US:en', 20:00:56 INFO - 'LOGNAME': 'cltbld', 20:00:56 INFO - 'MAIL': '/var/mail/cltbld', 20:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:56 INFO - 'MOZ_NO_REMOTE': '1', 20:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:56 INFO - 'NO_EM_RESTART': '1', 20:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:56 INFO - 'SHELL': '/bin/bash', 20:00:56 INFO - 'SHLVL': '1', 20:00:56 INFO - 'TERM': 'linux', 20:00:56 INFO - 'TMOUT': '86400', 20:00:56 INFO - 'USER': 'cltbld', 20:00:56 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:56 INFO - '_': '/tools/buildbot/bin/python'} 20:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:56 INFO - Downloading/unpacking psutil>=0.7.1 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:00:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:00:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:58 INFO - Installing collected packages: psutil 20:00:58 INFO - Running setup.py install for psutil 20:00:58 INFO - building 'psutil._psutil_linux' extension 20:00:58 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 20:00:58 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 20:00:58 INFO - building 'psutil._psutil_posix' extension 20:00:58 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 20:00:58 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 20:00:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:58 INFO - Successfully installed psutil 20:00:58 INFO - Cleaning up... 20:00:58 INFO - Return code: 0 20:00:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:00: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')]} 20:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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')]} 20:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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', '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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:00: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:00: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 mozsystemmonitor==0.0.0 20:00:58 INFO - Using env: {'DISPLAY': ':0', 20:00:58 INFO - 'HOME': '/home/cltbld', 20:00:58 INFO - 'LANG': 'en_US.UTF-8', 20:00:58 INFO - 'LANGUAGE': 'en_US:en', 20:00:58 INFO - 'LOGNAME': 'cltbld', 20:00:58 INFO - 'MAIL': '/var/mail/cltbld', 20:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:58 INFO - 'MOZ_NO_REMOTE': '1', 20:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:58 INFO - 'NO_EM_RESTART': '1', 20:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:58 INFO - 'SHELL': '/bin/bash', 20:00:58 INFO - 'SHLVL': '1', 20:00:58 INFO - 'TERM': 'linux', 20:00:58 INFO - 'TMOUT': '86400', 20:00:58 INFO - 'USER': 'cltbld', 20:00:58 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:58 INFO - '_': '/tools/buildbot/bin/python'} 20:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:01:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:01:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:01:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:01:00 INFO - Installing collected packages: mozsystemmonitor 20:01:00 INFO - Running setup.py install for mozsystemmonitor 20:01:00 INFO - Successfully installed mozsystemmonitor 20:01:00 INFO - Cleaning up... 20:01:00 INFO - Return code: 0 20:01:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:00 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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:01:00 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 20:01:00 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 20:01:00 INFO - Using env: {'DISPLAY': ':0', 20:01:00 INFO - 'HOME': '/home/cltbld', 20:01:00 INFO - 'LANG': 'en_US.UTF-8', 20:01:00 INFO - 'LANGUAGE': 'en_US:en', 20:01:00 INFO - 'LOGNAME': 'cltbld', 20:01:00 INFO - 'MAIL': '/var/mail/cltbld', 20:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:00 INFO - 'MOZ_NO_REMOTE': '1', 20:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:00 INFO - 'NO_EM_RESTART': '1', 20:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:00 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:00 INFO - 'SHELL': '/bin/bash', 20:01:00 INFO - 'SHLVL': '1', 20:01:00 INFO - 'TERM': 'linux', 20:01:00 INFO - 'TMOUT': '86400', 20:01:00 INFO - 'USER': 'cltbld', 20:01:00 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:00 INFO - '_': '/tools/buildbot/bin/python'} 20:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:01 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:01:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:01:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:01:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:01:02 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 20:01:02 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 20:01:02 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 20:01:02 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 20:01:02 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 20:01:02 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 20:01:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:01:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:01:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:01:03 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 20:01:03 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 20:01:03 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 20:01:03 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 20:01:03 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 20:01:03 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 20:01:03 INFO - Downloading docopt-0.6.1.tar.gz 20:01:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:01:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:01:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:01:03 INFO - Running setup.py install for blobuploader 20:01:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:01:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:01:03 INFO - Running setup.py install for requests 20:01:03 INFO - Running setup.py install for docopt 20:01:03 INFO - Successfully installed blobuploader requests docopt 20:01:03 INFO - Cleaning up... 20:01:04 INFO - Return code: 0 20:01:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:04 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')]} 20:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:04 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')]} 20:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:04 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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:01:04 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 20:01:04 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 20:01:04 INFO - Using env: {'DISPLAY': ':0', 20:01:04 INFO - 'HOME': '/home/cltbld', 20:01:04 INFO - 'LANG': 'en_US.UTF-8', 20:01:04 INFO - 'LANGUAGE': 'en_US:en', 20:01:04 INFO - 'LOGNAME': 'cltbld', 20:01:04 INFO - 'MAIL': '/var/mail/cltbld', 20:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:04 INFO - 'MOZ_NO_REMOTE': '1', 20:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:04 INFO - 'NO_EM_RESTART': '1', 20:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:04 INFO - 'SHELL': '/bin/bash', 20:01:04 INFO - 'SHLVL': '1', 20:01:04 INFO - 'TERM': 'linux', 20:01:04 INFO - 'TMOUT': '86400', 20:01:04 INFO - 'USER': 'cltbld', 20:01:04 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:04 INFO - '_': '/tools/buildbot/bin/python'} 20:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:04 INFO - Running setup.py (path:/tmp/pip-xZFOfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:04 INFO - Running setup.py (path:/tmp/pip-hlv9fl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:04 INFO - Running setup.py (path:/tmp/pip-8d1A9z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:04 INFO - Running setup.py (path:/tmp/pip-GMmg4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:04 INFO - Running setup.py (path:/tmp/pip-3tyfEF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:04 INFO - Running setup.py (path:/tmp/pip-3M_yKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:04 INFO - Running setup.py (path:/tmp/pip-GpNP2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:04 INFO - Running setup.py (path:/tmp/pip-iFr0bh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:04 INFO - Running setup.py (path:/tmp/pip-WlRQHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:04 INFO - Running setup.py (path:/tmp/pip-0_Zy0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:04 INFO - Running setup.py (path:/tmp/pip-9ECULj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:05 INFO - Running setup.py (path:/tmp/pip-6vulZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:05 INFO - Running setup.py (path:/tmp/pip-NDIjeJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:05 INFO - Running setup.py (path:/tmp/pip-u0UuVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:05 INFO - Running setup.py (path:/tmp/pip-Eh36DD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:05 INFO - Running setup.py (path:/tmp/pip-QBNRlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:05 INFO - Running setup.py (path:/tmp/pip-5fy51I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:01:05 INFO - Running setup.py install for manifestparser 20:01:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:01:05 INFO - Running setup.py install for mozcrash 20:01:05 INFO - Running setup.py install for mozdebug 20:01:05 INFO - Running setup.py install for mozdevice 20:01:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:01:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:01:05 INFO - Running setup.py install for mozfile 20:01:05 INFO - Running setup.py install for mozhttpd 20:01:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Running setup.py install for mozinfo 20:01:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Running setup.py install for mozInstall 20:01:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Running setup.py install for mozleak 20:01:06 INFO - Running setup.py install for mozlog 20:01:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Running setup.py install for moznetwork 20:01:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Running setup.py install for mozprocess 20:01:06 INFO - Running setup.py install for mozprofile 20:01:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Running setup.py install for mozrunner 20:01:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:01:06 INFO - Running setup.py install for mozscreenshot 20:01:07 INFO - Running setup.py install for moztest 20:01:07 INFO - Running setup.py install for mozversion 20:01:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:01:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:01:07 INFO - Cleaning up... 20:01:07 INFO - Return code: 0 20:01:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:07 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')]} 20:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:07 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')]} 20:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:07 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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:01:07 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 20:01:07 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 20:01:07 INFO - Using env: {'DISPLAY': ':0', 20:01:07 INFO - 'HOME': '/home/cltbld', 20:01:07 INFO - 'LANG': 'en_US.UTF-8', 20:01:07 INFO - 'LANGUAGE': 'en_US:en', 20:01:07 INFO - 'LOGNAME': 'cltbld', 20:01:07 INFO - 'MAIL': '/var/mail/cltbld', 20:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:07 INFO - 'MOZ_NO_REMOTE': '1', 20:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:07 INFO - 'NO_EM_RESTART': '1', 20:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:07 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:07 INFO - 'SHELL': '/bin/bash', 20:01:07 INFO - 'SHLVL': '1', 20:01:07 INFO - 'TERM': 'linux', 20:01:07 INFO - 'TMOUT': '86400', 20:01:07 INFO - 'USER': 'cltbld', 20:01:07 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:07 INFO - '_': '/tools/buildbot/bin/python'} 20:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:07 INFO - Running setup.py (path:/tmp/pip-OZI6i7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:07 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)) 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:07 INFO - Running setup.py (path:/tmp/pip-i_7Idm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:07 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)) 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:07 INFO - Running setup.py (path:/tmp/pip-h0ORUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:07 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)) 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:07 INFO - Running setup.py (path:/tmp/pip-kHFtZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:07 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)) 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:07 INFO - Running setup.py (path:/tmp/pip-01bho0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:07 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)) 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:07 INFO - Running setup.py (path:/tmp/pip-p5W9Is-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:07 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)) 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:07 INFO - Running setup.py (path:/tmp/pip-ChQ86f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:07 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)) 20:01:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:07 INFO - Running setup.py (path:/tmp/pip-ctELPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:08 INFO - Running setup.py (path:/tmp/pip-6GdDWV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:08 INFO - Running setup.py (path:/tmp/pip-sbcRy7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:08 INFO - Running setup.py (path:/tmp/pip-BxIUFI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:08 INFO - Running setup.py (path:/tmp/pip-rVWM84-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:08 INFO - Running setup.py (path:/tmp/pip-nr6D7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:08 INFO - Running setup.py (path:/tmp/pip-4vUVXS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:08 INFO - Running setup.py (path:/tmp/pip-o_PZ5Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:08 INFO - Running setup.py (path:/tmp/pip-nfuCR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:08 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)) 20:01:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:08 INFO - Running setup.py (path:/tmp/pip-OBr0hh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:08 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)) 20:01:08 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)) 20:01:08 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)) 20:01:08 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)) 20:01:08 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)) 20:01:08 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)) 20:01:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:08 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 20:01:08 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 20:01:08 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 20:01:08 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 20:01:08 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 20:01:08 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 20:01:10 INFO - Downloading blessings-1.5.1.tar.gz 20:01:10 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 20:01:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:10 INFO - Installing collected packages: blessings 20:01:10 INFO - Running setup.py install for blessings 20:01:10 INFO - Successfully installed blessings 20:01:10 INFO - Cleaning up... 20:01:10 INFO - Return code: 0 20:01:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:01:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:10 INFO - Reading from file tmpfile_stdout 20:01:10 INFO - Current package versions: 20:01:10 INFO - argparse == 1.2.1 20:01:10 INFO - blessings == 1.5.1 20:01:10 INFO - blobuploader == 1.2.4 20:01:10 INFO - docopt == 0.6.1 20:01:10 INFO - manifestparser == 1.1 20:01:10 INFO - mozInstall == 1.12 20:01:10 INFO - mozcrash == 0.16 20:01:10 INFO - mozdebug == 0.1 20:01:10 INFO - mozdevice == 0.47 20:01:10 INFO - mozfile == 1.2 20:01:10 INFO - mozhttpd == 0.7 20:01:10 INFO - mozinfo == 0.9 20:01:10 INFO - mozleak == 0.1 20:01:10 INFO - mozlog == 3.1 20:01:10 INFO - moznetwork == 0.27 20:01:10 INFO - mozprocess == 0.22 20:01:10 INFO - mozprofile == 0.28 20:01:10 INFO - mozrunner == 6.11 20:01:10 INFO - mozscreenshot == 0.1 20:01:10 INFO - mozsystemmonitor == 0.0 20:01:10 INFO - moztest == 0.7 20:01:10 INFO - mozversion == 1.4 20:01:10 INFO - psutil == 3.1.1 20:01:10 INFO - requests == 1.2.3 20:01:10 INFO - wsgiref == 0.1.2 20:01:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:10 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')]} 20:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:10 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')]} 20:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:10 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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:01:10 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 20:01:10 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 20:01:10 INFO - Using env: {'DISPLAY': ':0', 20:01:10 INFO - 'HOME': '/home/cltbld', 20:01:10 INFO - 'LANG': 'en_US.UTF-8', 20:01:10 INFO - 'LANGUAGE': 'en_US:en', 20:01:10 INFO - 'LOGNAME': 'cltbld', 20:01:10 INFO - 'MAIL': '/var/mail/cltbld', 20:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:10 INFO - 'MOZ_NO_REMOTE': '1', 20:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:10 INFO - 'NO_EM_RESTART': '1', 20:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:10 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:10 INFO - 'SHELL': '/bin/bash', 20:01:10 INFO - 'SHLVL': '1', 20:01:10 INFO - 'TERM': 'linux', 20:01:10 INFO - 'TMOUT': '86400', 20:01:10 INFO - 'USER': 'cltbld', 20:01:10 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:10 INFO - '_': '/tools/buildbot/bin/python'} 20:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 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)) 20:01:10 INFO - Cleaning up... 20:01:11 INFO - Return code: 0 20:01:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:01: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')]} 20:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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')]} 20:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:01: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', 'jsonschema'] in /builds/slave/test-pgo/build 20:01: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 jsonschema 20:01:11 INFO - Using env: {'DISPLAY': ':0', 20:01:11 INFO - 'HOME': '/home/cltbld', 20:01:11 INFO - 'LANG': 'en_US.UTF-8', 20:01:11 INFO - 'LANGUAGE': 'en_US:en', 20:01:11 INFO - 'LOGNAME': 'cltbld', 20:01:11 INFO - 'MAIL': '/var/mail/cltbld', 20:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:11 INFO - 'MOZ_NO_REMOTE': '1', 20:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:11 INFO - 'NO_EM_RESTART': '1', 20:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:11 INFO - 'SHELL': '/bin/bash', 20:01:11 INFO - 'SHLVL': '1', 20:01:11 INFO - 'TERM': 'linux', 20:01:11 INFO - 'TMOUT': '86400', 20:01:11 INFO - 'USER': 'cltbld', 20:01:11 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:11 INFO - '_': '/tools/buildbot/bin/python'} 20:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:11 INFO - Downloading/unpacking jsonschema 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:12 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 20:01:12 INFO - Downloading/unpacking functools32 (from jsonschema) 20:01:12 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 20:01:12 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 20:01:12 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 20:01:12 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 20:01:12 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 20:01:12 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 20:01:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:01:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:13 INFO - warning: no files found matching '*.txt' 20:01:13 INFO - no previously-included directories found matching 'build' 20:01:13 INFO - no previously-included directories found matching 'dist' 20:01:13 INFO - no previously-included directories found matching '.git*' 20:01:13 INFO - Installing collected packages: jsonschema, functools32 20:01:13 INFO - Running setup.py install for functools32 20:01:13 INFO - warning: no files found matching '*.txt' 20:01:13 INFO - no previously-included directories found matching 'build' 20:01:13 INFO - no previously-included directories found matching 'dist' 20:01:13 INFO - no previously-included directories found matching '.git*' 20:01:13 INFO - Successfully installed jsonschema functools32 20:01:13 INFO - Cleaning up... 20:01:13 INFO - Return code: 0 20:01:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:01:13 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')]} 20:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:13 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')]} 20:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:13 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 0x7fb55e8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2770480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', '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 20:01:13 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 20:01:13 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 20:01:13 INFO - Using env: {'DISPLAY': ':0', 20:01:13 INFO - 'HOME': '/home/cltbld', 20:01:13 INFO - 'LANG': 'en_US.UTF-8', 20:01:13 INFO - 'LANGUAGE': 'en_US:en', 20:01:13 INFO - 'LOGNAME': 'cltbld', 20:01:13 INFO - 'MAIL': '/var/mail/cltbld', 20:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:13 INFO - 'MOZ_NO_REMOTE': '1', 20:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:13 INFO - 'NO_EM_RESTART': '1', 20:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:13 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:13 INFO - 'SHELL': '/bin/bash', 20:01:13 INFO - 'SHLVL': '1', 20:01:13 INFO - 'TERM': 'linux', 20:01:13 INFO - 'TMOUT': '86400', 20:01:13 INFO - 'USER': 'cltbld', 20:01:13 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:13 INFO - '_': '/tools/buildbot/bin/python'} 20:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:13 INFO - Downloading/unpacking flake8 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01: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 20:01:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:01:15 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 20:01:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:01:15 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 20:01:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 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 20:01:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:01:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:15 INFO - no previously-included directories found matching 'docs/_build' 20:01:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:01:15 INFO - Running setup.py install for pep8 20:01:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:16 INFO - no previously-included directories found matching 'docs/_build' 20:01:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:01:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:01:16 INFO - Cleaning up... 20:01:16 INFO - Return code: 0 20:01:16 INFO - Running post-action listener: _resource_record_post_action 20:01:16 INFO - Running post-action listener: _start_resource_monitoring 20:01:16 INFO - Starting resource monitoring. 20:01:16 INFO - ##### 20:01:16 INFO - ##### Running install step. 20:01:16 INFO - ##### 20:01:16 INFO - Running pre-action listener: _resource_record_pre_action 20:01:16 INFO - Running main action method: install 20:01:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:16 INFO - Reading from file tmpfile_stdout 20:01:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:01:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:01:16 INFO - Reading from file tmpfile_stdout 20:01:16 INFO - Output received: 20:01:16 INFO - Usage: mozinstall [options] installer 20:01:16 INFO - Options: 20:01:16 INFO - -h, --help show this help message and exit 20:01:16 INFO - -d DEST, --destination=DEST 20:01:16 INFO - Directory to install application into. [default: 20:01:16 INFO - "/builds/slave/test-pgo"] 20:01:16 INFO - --app=APP Application being installed. [default: firefox] 20:01:16 INFO - mkdir: /builds/slave/test-pgo/build/application 20:01:16 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'] 20:01:16 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 20:01:32 INFO - Reading from file tmpfile_stdout 20:01:32 INFO - Output received: 20:01:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:01:32 INFO - Running post-action listener: _resource_record_post_action 20:01:32 INFO - ##### 20:01:32 INFO - ##### Running run-tests step. 20:01:32 INFO - ##### 20:01:32 INFO - Running pre-action listener: _resource_record_pre_action 20:01:32 INFO - Running main action method: run_tests 20:01:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:01:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:01:32 INFO - Python 2.7.3 20:01:32 INFO - Return code: 0 20:01:32 INFO - grabbing minidump binary from tooltool 20:01: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')]} 20:01:32 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 0x27ff660>, '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 0x2800560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2800a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:01:32 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 20:01:32 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 20:01:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:01:32 INFO - Return code: 0 20:01:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:01:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:01:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:01:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:01:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:01:33 INFO - Return code: 0 20:01:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 20:01:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 20:01:33 INFO - Using env: {'DISPLAY': ':0', 20:01:33 INFO - 'HOME': '/home/cltbld', 20:01:33 INFO - 'LANG': 'en_US.UTF-8', 20:01:33 INFO - 'LANGUAGE': 'en_US:en', 20:01:33 INFO - 'LOGNAME': 'cltbld', 20:01:33 INFO - 'MAIL': '/var/mail/cltbld', 20:01:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:33 INFO - 'MOZ_NO_REMOTE': '1', 20:01:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:33 INFO - 'NO_EM_RESTART': '1', 20:01:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:33 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:01:33 INFO - 'SHELL': '/bin/bash', 20:01:33 INFO - 'SHLVL': '1', 20:01:33 INFO - 'TERM': 'linux', 20:01:33 INFO - 'TMOUT': '86400', 20:01:33 INFO - 'USER': 'cltbld', 20:01:33 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510', 20:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:33 INFO - '_': '/tools/buildbot/bin/python'} 20:01:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:01:33 INFO - mozversion application_buildid: 20151231173004 20:01:33 INFO - mozversion application_changeset: 6786ccb1dba475cb92f0a69b8daf544d4213c8da 20:01:33 INFO - mozversion application_display_name: Nightly 20:01:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:01:33 INFO - mozversion application_name: Firefox 20:01:33 INFO - mozversion application_remotingname: firefox 20:01:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:01:33 INFO - mozversion application_vendor: Mozilla 20:01:33 INFO - mozversion application_version: 46.0a1 20:01:33 INFO - mozversion platform_buildid: 20151231173004 20:01:33 INFO - mozversion platform_changeset: 6786ccb1dba475cb92f0a69b8daf544d4213c8da 20:01:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:01:33 INFO - mozversion platform_version: 46.0a1 20:01:33 INFO - using testdate: 1451620893 20:01:33 INFO - actual date: 1451620893 20:01:33 INFO - starting webserver on 'localhost:41747' 20:01:33 INFO - SUITE-START | Running 3 tests 20:01:33 INFO - TEST-START | dromaeo_css 20:01:33 INFO - operating with platform_type : linux_ 20:01:33 INFO - Initialising browser for dromaeo_css test... 20:01:33 INFO - TEST-INFO | started process 13662 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdRAZNv/profile http://localhost:41747/getInfo.html) 20:01:37 INFO - PROCESS | 13662 | __metrics Screen width/height:1600/1200 20:01:37 INFO - PROCESS | 13662 | colorDepth:24 20:01:37 INFO - PROCESS | 13662 | Browser inner width/height: 1024/697 20:01:37 INFO - PROCESS | 13662 | __metrics 20:01:37 INFO - PROCESS | 13662 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:01:37 INFO - PROCESS | 13662 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:01:38 INFO - TEST-INFO | 13662: exit 0 20:01:38 INFO - Browser initialized. 20:01:38 INFO - Running cycle 1/1 for dromaeo_css test... 20:01:38 INFO - TEST-INFO | started process 13758 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdRAZNv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:01:50 INFO - PROCESS | 13758 | RSS: Main: 150073344 20:01:50 INFO - PROCESS | 13758 | 20:02:41 INFO - PROCESS | 13758 | 1451620961924 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] 20:04:50 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:41747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41747/tests/dromaeo/cssquery-ext.html) 20:04:51 INFO - PROCESS | 13758 | RSS: Main: 253382656 20:04:51 INFO - PROCESS | 13758 | 20:07:54 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:41747/tests/dromaeo/cssquery-ext.html (next: http://localhost:41747/tests/dromaeo/cssquery-jquery.html) 20:07:54 INFO - PROCESS | 13758 | RSS: Main: 228335616 20:07:54 INFO - PROCESS | 13758 | 20:10:56 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:41747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41747/tests/dromaeo/cssquery-mootools.html) 20:10:57 INFO - PROCESS | 13758 | RSS: Main: 231907328 20:10:57 INFO - PROCESS | 13758 | 20:13:58 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:41747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41747/tests/dromaeo/cssquery-prototype.html) 20:13:59 INFO - PROCESS | 13758 | RSS: Main: 210948096 20:13:59 INFO - PROCESS | 13758 | 20:17:01 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:41747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41747/tests/dromaeo/cssquery-yui.html) 20:17:02 INFO - PROCESS | 13758 | RSS: Main: 214859776 20:17:02 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | Cycle 1(1): loaded http://localhost:41747/tests/dromaeo/cssquery-yui.html (next: http://localhost:41747/tests/dromaeo/cssquery-dojo.html) 20:20:05 INFO - PROCESS | 13758 | RSS: Main: 257249280 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | __start_tp_report 20:20:05 INFO - PROCESS | 13758 | _x_x_mozilla_page_load 20:20:05 INFO - PROCESS | 13758 | _x_x_mozilla_page_load_details 20:20:05 INFO - PROCESS | 13758 | |i|pagename|runs| 20:20:05 INFO - PROCESS | 13758 | |0;dojo.html;3070.6008218931543;3160.494320908655;3208.8074715517073;3212.277237621534;3239.1416274687213;5156.92264616031;5266.138165345414;5271.6836989780595;5272.209168624709;5346.304980352558;5180.3006594109875;5242.292290540776;5274.868128296785;5277.208418737191;5311.336082989626;4866.707997520151;4885.877853053685;4903.509649035103;4906.190478571031;4969.105560999019;4927.433345165316;4977.303177555145;5012.72430016349;5020.246962955549;5058.190689489682;4749.857504274877;4801.68789028712;4858.5384388483035;4925.581325587329;4930.901381972359;4883.267509873512;4901.411830580318;4904.60763138948;4911.214205727067;4917.0903382874285;4840.75796210188;4853.514648535153;4866.756662166913;4870.756462176877;4892.681975671606;5050.949490505084;5134.0502007128425;5188.844334669966;5215.1134307167495;5272.288241087481;5598.552115830724;5668.97165514174;5735.741891614887;5741.971290143564;5754.136879468071;5695.7152142392715;5703.429657034305;5725.198472213893;5728.570357223225;5732.684702341369;5292.444293349181;5293.894122117575;5299.152135658276;5301.151815709468;5323.707196104213;5632.662040277514;5637;5737.713114344266;5766.394528574523;5786.71066446676;5510.448955104457;5578.41426650204;5579.609427340129;5585.720713964367;5616.438356164433;5647.774089036392;5649.096144616841;5650.943490565041;5651.321841379061;5662.292213473316;5514.283143191359;5580.581456390787;5590.776368945197;5632.718364081861;5635.802746903921;5660.716964151776;5668.688222147822;5676.091825307931;5690.2033715279895;5701.942980570224;4389.956100439019;4392.538783427758;4408.7575183365225;4412.779361031936;4434.357018232338;3883.708721845873;3884.028992751812;3934.272159650474;3959.4852669152824;3960.9009774755286;5284.656497327662;5302.549283310885;5311.415744268127;5319.601029922694;5348.893022139536;5705.5435565154685;5706.28671416073;5706.657600543981;5712.542996560265;5728.942710572841;5146.794128234904;5227.973860130675;5235.214717792362;5253.44838791929;5324.094903866352;4855.587275081587;4873.610111191168;4884.3161957326;4886.95113048865;4947.975260123676;5870.706464676835;5879.617824841372;5885.17607534954;5886;5913.172155898092;5549.611527193219;5604.411536788579;5659.3491748447805;5662.801801936913;5790.710464476675;5917;5922.230110085661;5926.259217597801;5932.970335148297;5942.702864856827;5633.0705433603;5658.094704847204;5659.122835960433;5659.292588426447;5670.829875103754;5567.331920169606;5627.971860140673;5649.406812284816;5650.180723795109;5728.341240757366;5507.642003269774;5547.55619550443;5556.444355564573;5565.6104072714525;5591.049521581423;5523.6409633373705;5545.916811247916;5547.389787123332;5552.916706249491;5591.972040139936;5338.172583249602;5381.1121165007335;5414.539764120094;5436.293281873332;5500.80747173847;5604.187392828098;5611.3266408031295;5615.213870058276;5624.04391253496;5675.517581005661;5504;5507.146392309199;5508.0911649578975;5508.283923089973;5509.393966663583 20:20:05 INFO - PROCESS | 13758 | |1;ext.html;537.7230726176018;584.1733946465752;599.8470390050538;600.4385899184263;602.8794241151771;27588.862055689744;35816.641833581656;35959.4606080909;36090.09774755633;36120.27759444816;40581.7970910145;41504.58495415052;41542;41564;41594.58405415945;7354.227806080365;7453.068366454193;8546.14538546145;8783.47299162049;8793.736187914374;9949.75125621858;10212.744681382988;10222.182225421986;10226.23303252259;10236.590536378573;9994.650187243411;10111.191104711605;10127.240456965721;10134.189264858793;10140.797184056315;7550.584717840489;7695.846083078363;7708.306252437307;7710.460267781257;9902.653407130752;10002.04980526856;10198.541065651989;10244.897551024469;10246.333988290737;10257.794844103151;35713.46429803555;35809.641903580894;36060.459093113626;36106.277874442625;36107;3253.251752097031;3285.8849940251976;3289.490129030004;3381.7463690223085;3385.86456541738;27408.17775466719;27991.440171196664;28372.43255134886;29791;29887.551686724717;3185.7132858042887;3238.9676103239135;3262.755293352984;3268.934621307584;3324.0526449961885;263721;263836;263874;264308;264582.9999999981;49842.501574983784;50428.24357634639;55175.44824551784;55569.72215138898;57215.71392143013;53572;53579;53911.46088539065;53966.46033539614;54004.45995540073;13877.097988630707;13951.162930224218;13966.301684915918;14011.08927919682;14038.087524310888;9739.41563506192;9740.172085372822;9741.123298903132;9745.31782775199;9774.26692998028;18489.7226541602;19030;19217.423477295702;19227.134778934982;19331.323403680803;7517.361024312994;7765.805854853674;7820.217978202134;7845.411594130463;7858.528488290721;922.6447817590276;995.9800803983879;1050.968470945873;1051.332403923514;1073.7476692977143;30359.392812143633;31470.1841165158;31774.523382149287;31841.203969900936;32367.51448728271;1016.5476363018386;1033;1066.983995240072;1129.632869317475;1138.3397629374942;14213.715725685428;14294.642633934234;14428.350724217435;14445.711085778226;14596.635084122769;301514;305160;305622;305813;305829;48842;48930.26604600934;49003.50996490061;49065.509344906095;49123.75438122787;1191.5769901684778;1255.6860784803798;1359.5649392194402;1378.3935068569797;1472.5729538433948;25541.61687574725;27558;27569.86215068992;27618.447631047668;28024.57963130514;40981.590184097775;41476.37785433161;41647;41754.37368439537;41880.79059604683;181025;184305.07847460677;304956;306049;309392;29386.265343366587;29528;29569.85215073911;29571.408571828873;29602.851985739933;38552.42171367488;39472;39532.2093558133;39844.40233396443;39958.60041399549;32412.837935811112;33019;33375.83312083424;33765.66234337625;34020.48969265413;34708.305833882674;35285.29429411449;36302.455463168604;36392.27215455729;36446.27107457889;32463;32689.673103268662;32845.50731739074;33010.66989330076;35823.104422389646;27169.24836520037;28551.714482854906;30927.69072309248;31728.365432690756;31749.523757144125;24516.632250516614;24950;24996.875015624806;25088.37279067965;25347.366315842253 20:20:05 INFO - PROCESS | 13758 | |2;jquery.html;352.3165059784019;352.8729657323361;355.90212691509834;357.71561608521216;359.4913197825078;14188.71622567548;14236;16420.67158656826;17027.82972170278;18181.27280907863;13764.587062388144;14406.27968601571;14696.55910322692;14698.926505367459;14706.48527301542;5340.038793017265;5463.48096930791;5465.234867118606;5466.644668096581;5477.123660214366;4135.565765594614;4200.0339921818;5408.0535906216255;5427.240186373911;6038.879222415549;6052.485538729214;6098.542609304298;6125.387461253884;6133.969330153365;6141.600795948271;5355.705436201008;5513.8345849624375;5514.420985796473;5516.613837031409;6089.81730548082;5126.769295381717;5288.550473209782;5295.629305948585;5303.443138470444;5304.045271851065;12518.186317889307;12702.301373424458;12718.473783146082;12728.872711272861;16819.747703784455;1966.7148263501713;2049.3749406431034;2075.1803037800137;2132.0405817382084;2170.674398840171;9889.109980101754;11352.545898164064;12398.194117382342;12712.872871271355;13207.075504714674;1732;1826.4429349048535;1845.5865866115275;1858.618983108473;1917.7027560728109;56842;59530;61060.389396105915;61210;61865.38134618641;10357.533910974023;10374.533146008447;10423.843642345371;10487.685369438928;10554.577816887391;13524.526641567498;13530.797038044437;13542.932285338708;13564.796528052088;13581.524646637321;6494.935050649433;6500.187476565429;6500.837479062967;6607.80176594703;6705.4970877184405;5811.56413268998;5846.94153058464;5888.617239879394;5893.970530147321;5907;4497.955020449754;4531.18438681034;4537.319402089647;4585.79363928624;4611.631069514431;1770.8848924819845;1818.945431637053;1824.5165031266724;1831.542114471382;1842.861785366076;917.9311551633655;935.9953200233955;990.3958585262984;1016.2733645443543;1020.811149937264;16186.75719864203;16886.831131688527;17013.319467221172;17357.65284694299;17464.126793660267;903.1284810158229;923.2014307623991;925.8102089071724;938.0197693410266;970.1850445625568;8975.28197744179;9821.312508124363;9890.20878329732;9893.35693179941;9978.501074946369;420250;423172;556467;560149;562458;41440.1711965759;42004.57995420068;45285.54714452879;67951.66024169847;69828.6508567464;1126.1947707389256;1132.8357388178667;1141.937193454368;1147.4320211495196;1155.4049664422828;15623;15800.130992795046;15901.920490397473;15940;16164.919175404048;19844.70232946478;25306.746932530437;26194.214173574823;35311.64688353083;35404.052777096476;45930.31104533368;46179;46617;47640.2853957184;47865.76067119642;9571.808563828823;9595.28035397334;9676.9032309676;9712.805743884941;9780.902190977999;16608.667826643643;16648.750268746222;16936.068516231724;17387.82612173862;17566.297348106444;10945.288556243819;13763.449462021406;14076.366563504462;14337.713245735236;14362.712745745235;13625.454981800616;13671.690241121427;13724.176549407068;14038.508652197532;14227.857721422653;13769.105008174436;14222.928885355506;14259.215743134228;14542.4910128145;14651.413943442143;8699.13008699125;8887.911120888708;8895.06601806801;9026.503542304974;9045.050269721585;10764.569417223223;14575.489857854924;14576.927115364779;14878.181700006604;14955.476558320406 20:20:05 INFO - PROCESS | 13758 | |3;mootools.html;1323.225912840988;1502.9023113497624;1503.6767095074556;1658.7677725118479;1808.1140241281769;6961.164660240772;7635.885461718071;7741.071071471417;7749.728759493419;7751.0311211098615;7509.812254693636;7674.808129796744;7692.3461505772075;7693.422993275512;7695.884561731565;2002.1590931808603;2030.1980717616532;2032.2683833819813;2263.7170353705787;2311.1564279038116;2032.9186832526682;2247.314569056437;2269.217120093573;2278.498730279336;2281.5094754627753;2177.46652070243;2217.6784366266884;2218.201447478906;2221.1115553778454;2291.232437133562;2265.365697604673;2281.0305620111553;2294.403455101677;2296.724393072842;2299.3906614747107;2218.279059305732;2261.2311813983324;2262.857257085178;2263.2418139923147;2270.5345404192103;7618.428617853628;7703.3452156566755;7704.383649308098;7706;7706.344960678349;4430.29115341547;4476.843310484118;4502.909941801146;4504.414426124616;4505.797239124247;2957.778166637511;3093.7215650591556;3093.9690603093904;3117.423276693796;3117.7817552771317;955.159459675488;977.6040703515088;980.4068538534227;1013.5844303835393;1049.082053203447;10663.946680266627;10664.573417063308;10667.14662826972;10685.145188384911;10696.251262411633;4216.936745948752;4227.112306415625;4253.80857861397;4274.337477690963;4276.465441819772;9146.451212927246;9153.862692059625;9168.083191680911;9172.495512746864;9173.908260917438;4625.653076019312;4629.1436084324505;4631.282151266559;4633.374494443275;4633.7683115844075;4184.121334519785;4185.497740271187;4193.287141185945;4196.769177695195;4201.537830838605;3359.193793489545;3553.2538166985223;3608.1160115771804;3640.7269454791;3655.3054919565197;1091.1652585771733;1129.728865072393;1154.7979103656826;1157.8379026936236;1169.900558452541;1023.7850051489122;1023.8464230365505;1069.8716154061563;1183.7632473505334;1355.722076974218;6385;6444.967775161094;6456.322086180978;6466.870662586722;6469.450096741735;1000.7798284377425;1014.9949250253701;1018.6129270877168;1024.2727663359099;1024.3188279793853;5664.85837854057;5717.199592057115;5759.94240057594;5769.048107062372;5770.596058275964;8975.23710484603;9369.859452108223;9471.242300615933;9479.810403791886;9485.66800161991;9240.95379523098;9312.580933857857;9330.066993300752;9367.672131475365;9387.812243755086;7140.892886606705;7226.963865180641;7227.241139680258;7290.161631412349;7300.6349682515665;7192.748253811301;7255.673494692857;7301.5031918455525;7306.6711997959155;7328.413726901942;8293.751187464386;8341.874871876806;8554;8554.27288680469;8554.78613034679;8590.35572332065;8805.603747831236;8814.162654547808;8815;8816.471011739317;7095.538789978635;7194.640267986684;7195.208527062124;7203.063601731741;7206.855862882818;6637.767678131242;6900.137482814648;7671.462997590115;7717.382609391348;7725.072991241087;6884.345987131214;6922.411595014279;7002.404795592228;7100.970359297976;7146.678399471933;6616.338366163345;6695.564788288746;6708.731650733916;6821.624810635462;6861.416779573592;6822.727090916308;6861.176658800976;6862.691178897061;6866.862662746817;6868.347506986828;6274.341194174546;6354.90467642995;6408.263049749338;6416.807495775134;6422.775202867877;6515.706793194412;6556.442702370352;6565.835854103686;6567.44176744982;6569.638669873203 20:20:05 INFO - PROCESS | 13758 | |4;prototype.html;348.66179805588575;351.90322661268164;352.6315000824139;352.73721077797035;355.2309250472725;5924.881502369955;5928.496077833384;5937.495312898403;5948.821535353935;5975.43056485711;5636.351819540754;5701.34434540028;5772.797952071678;5817.360090390053;5897.557683173758;4612.561806628365;4632.837850675227;4636.4899861015265;4647.790849411767;4654.301854721785;4617.07658468306;4621.260598304272;4622.699524530912;4627.3521706961055;4636;4330.307150855863;4401.339799030139;4456.799444025027;4594.74728889911;4603.4015577974815;4579.7481138537205;4587.678862479628;4595.494495605481;4600.539946005372;4611.492735799059;4056.553779084298;4066.451029111062;4066.877993660195;4067.918641627151;4069.3895915612597;5542.057850165482;5550.27846379972;5555.611107222496;5557.833265002016;5559;5175.120229560946;5341.973290133525;5369;5393.541548968343;5399.379071406799;6211.223597050369;6217.937820621781;6224.937750622526;6228.844278893019;6229.563930524865;4499.662525310615;4507.639388848885;4507.842225522091;4509.932351014738;4517.2094883395275;6391.392817682313;6473.158489396395;6548.312427195124;6569.901451478232;6578.671066446658;4661.557152070548;4661.883452913704;4662.207424737802;4669.929951050737;4676.50896655853;4732.574068333866;4732.929006064912;4735.857924262277;4741.644376671763;4744.691595046311;5361.839144825662;5364.946350536523;5375.3280839895015;5376.166694162411;5382.811601593926;6173.506119510428;6314.8421289467215;6328.082428047999;6328.272248691367;6346.143270658495;1655.7847479827544;1676.3964972609851;1677.790276215473;1677.8406051425095;1679.0429455210658;1143.3311512765126;1151.027381862325;1151.9827202591969;1175.1421462332546;1176.2824676947055;5951.880962380728;5958.493528050078;5960.523158147338;5961.01643228871;5977.880442391128;6468.935310646927;6502;6509.837254068591;6517.9348206517325;6519.4132528072705;5774.480296773227;5803.274590676166;5921.851953701192;5941.049432090845;5994.310654274815;3495.2834668892815;3504.0714210734177;3510.227749895019;3525.576930768273;3529.2764983178386;6806.387425131762;6815.625140617313;6816.4546836252985;6898.344657257552;6901.378875901193;6622;6705.530612857151;6732.427743641747;6740.29226931175;6749;6806.557573757789;6817.216020157646;6821.147356580427;6823.147106611674;6829.18049834033;6551.279359270572;6552.868942621216;6561.704723287368;6568.901466477911;6569.770058047945;6333.081703152925;6462.483001359786;6468.094466774562;6473.126127972663;6479.125318082187;6796.558223715443;6799.558028728117;6804;6804.795856124324;6808.489363297674;4557.567031132037;4570.360149578995;4576.771161441981;4585.770711464346;4589.9541004590865;6385.87228255423;6534.987077003072;6542.705578249085;6554.246261679968;6559.442447392025;6372.0760489729655;6372.55392122547;6373.075903993802;6375.649339286384;6384.840378990377;6352.078948552342;6354.269259035085;6354.745810167541;6368.140301059298;6370.426661600478;6156.199694039746;6203.937960620336;6239.188905442264;6256.436920677161;6258.468030217483;6389.616623002635;6390.7443702251385;6392.296847346881;6397;6397.808065758035;6239.0953311768635;6245.219347581552;6250.249970003447;6251.406116419115;6262.185915830913 20:20:05 INFO - PROCESS | 13758 | |5;yui.html;733.5928559649395;814.4950130918829;852.9189726975939;852.9530875801836;868.5179725252482;12283.508659653615;12471.314077725721;12474.875251247484;12484.438200280998;12502.374881255924;11511;11961.16271860968;11975.341356225405;11983.940080299608;11991.820122698145;687.9002544631026;694.4791406445166;697.2609034423502;825.7357645553425;845.344857735254;834.7996480844583;836.2056046755577;841.869510225916;842.0442797424905;842.6671464771412;875.8204568063531;876.3865294293988;878.4246318661287;878.5299864572455;879.0155026370473;722.6639612580149;731.4843035659848;864.7059999600166;876.4259410086404;879.5030807593689;645.8611398549288;647.1910112359551;647.2556559956041;647.9449246814027;648.1412128929188;12191.963683086948;12322.75354492914;12325.815112773316;12343.753124937452;12346.320952347618;12390.62828115149;12501.437435315342;12652.68368290791;12924.289164095972;13180.209187448689;10576.788464230749;10827.24209305349;10831.67504974852;11061.557537698482;11204;3583.87456439026;3587.892363229107;3618.4391419330045;3618.8190590470635;3680.190358121209;42697.14605707899;46935.295970560466;47110.76444617755;47177.764111179225;47235.76382118102;9945.20438364929;10081.243906707026;10096.495175241209;10200.38797672142;10232.64185753495;18002.5499362517;18055.54861128456;18080.819191807914;18113.094345282683;18169.81830181708;6973.895391569131;7146.785596432115;7147.678354473957;7156.749513766993;7177.354038136488;4257.19113368459;4260;4273.786310684453;4275.828966841354;4277.615014648696;3267.5262086997254;3294.950575741366;3295.846453741219;3306.9503957440656;3309.619393769699;573.6357413042748;587.3216435017562;595.2886300870418;600.3786081405812;606.0454783715666;577.9364269930304;604.3774911840811;614.2230078950132;659.3867703036223;682.4983637026781;8683.131686831393;8914.242289405343;9077.863832042525;9090.3212649653;9090.636374544943;547.5537436988841;569.9658020518782;698.6995591895534;699.8705239530601;729.1614643160408;3857.3828187489867;3873.9225215496094;4128.814203360856;4204.243236217449;4249.617534421917;49140.75429622829;49175.75412122988;49184.50815491871;49647.50352496501;49757.50242497529;45706.54293457089;45883.5411645886;45976.540234597225;46517.534824652;52239.47760522346;46371.30443043357;46743.76628116838;47721.5227847724;48005.75997119992;48086;7878.4091193161885;7880.724174653859;8006.279434850659;8031.839363212586;8045.87931181021;34627.30745385028;35535.11162220965;35702.4644630336;35728.28543429169;35858.28283434369;43894;46242.7687861572;46418.535814642775;46474.535254647024;46499.76750116363;10358.948205259227;10456.529456174643;10512.737181570523;10655.86834817588;10726.785464290515;11659.825102623638;11798.115141364604;11890.227135236182;11930.463129159381;11952.163348565517;10631.308964917256;10717.303375280582;10863.511141998471;10913.181511386836;10930.070943969533;10776.353418794897;10822.40476773785;10914.23600347968;11075.778484430428;11372;9595.856062158933;9866.654667086617;9964.352317099365;10245.897541024495;10275.7431064224;9519.524023798644;9595.328327017321;9671;9721.814061215737;9933.453660048766;8830.249428798625;9338.299627528098;9369.166109275304;9371.85942210881;9385.20225780789 20:20:05 INFO - PROCESS | 13758 | __end_tp_report 20:20:05 INFO - PROCESS | 13758 | __start_cc_report 20:20:05 INFO - PROCESS | 13758 | _x_x_mozilla_cycle_collect,913 20:20:05 INFO - PROCESS | 13758 | __end_cc_report 20:20:05 INFO - PROCESS | 13758 | __startTimestamp1451622005371__endTimestamp 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | ------- Summary: start ------- 20:20:05 INFO - PROCESS | 13758 | Number of tests: 6 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | [#0] dojo.html Cycles:165 Average:5279.79 Median:5507.64 stddev:571.60 (10.4%) stddev-sans-first:546.45 20:20:05 INFO - PROCESS | 13758 | Values: 3070.6 3160.5 3208.8 3212.3 3239.1 5156.9 5266.1 5271.7 5272.2 5346.3 5180.3 5242.3 5274.9 5277.2 5311.3 4866.7 4885.9 4903.5 4906.2 4969.1 4927.4 4977.3 5012.7 5020.2 5058.2 4749.9 4801.7 4858.5 4925.6 4930.9 4883.3 4901.4 4904.6 4911.2 4917.1 4840.8 4853.5 4866.8 4870.8 4892.7 5050.9 5134.1 5188.8 5215.1 5272.3 5598.6 5669.0 5735.7 5742.0 5754.1 5695.7 5703.4 5725.2 5728.6 5732.7 5292.4 5293.9 5299.2 5301.2 5323.7 5632.7 5637.0 5737.7 5766.4 5786.7 5510.4 5578.4 5579.6 5585.7 5616.4 5647.8 5649.1 5650.9 5651.3 5662.3 5514.3 5580.6 5590.8 5632.7 5635.8 5660.7 5668.7 5676.1 5690.2 5701.9 4390.0 4392.5 4408.8 4412.8 4434.4 3883.7 3884.0 3934.3 3959.5 3960.9 5284.7 5302.5 5311.4 5319.6 5348.9 5705.5 5706.3 5706.7 5712.5 5728.9 5146.8 5228.0 5235.2 5253.4 5324.1 4855.6 4873.6 4884.3 4887.0 4948.0 5870.7 5879.6 5885.2 5886.0 5913.2 5549.6 5604.4 5659.3 5662.8 5790.7 5917.0 5922.2 5926.3 5933.0 5942.7 5633.1 5658.1 5659.1 5659.3 5670.8 5567.3 5628.0 5649.4 5650.2 5728.3 5507.6 5547.6 5556.4 5565.6 5591.0 5523.6 5545.9 5547.4 5552.9 5592.0 5338.2 5381.1 5414.5 5436.3 5500.8 5604.2 5611.3 5615.2 5624.0 5675.5 5504.0 5507.1 5508.1 5508.3 5509.4 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | [#1] ext.html Cycles:180 Average:43665.03 Median:17858.13 stddev:72724.24 (407.2%) stddev-sans-first:72856.16 20:20:05 INFO - PROCESS | 13758 | Values: 537.7 584.2 599.8 600.4 602.9 27588.9 35816.6 35959.5 36090.1 36120.3 40581.8 41504.6 41542.0 41564.0 41594.6 7354.2 7453.1 8546.1 8783.5 8793.7 9949.8 10212.7 10222.2 10226.2 10236.6 9994.7 10111.2 10127.2 10134.2 10140.8 7550.6 7695.8 7708.3 7710.5 9902.7 10002.0 10198.5 10244.9 10246.3 10257.8 35713.5 35809.6 36060.5 36106.3 36107.0 3253.3 3285.9 3289.5 3381.7 3385.9 27408.2 27991.4 28372.4 29791.0 29887.6 3185.7 3239.0 3262.8 3268.9 3324.1 263721.0 263836.0 263874.0 264308.0 264583.0 49842.5 50428.2 55175.4 55569.7 57215.7 53572.0 53579.0 53911.5 53966.5 54004.5 13877.1 13951.2 13966.3 14011.1 14038.1 9739.4 9740.2 9741.1 9745.3 9774.3 18489.7 19030.0 19217.4 19227.1 19331.3 7517.4 7765.8 7820.2 7845.4 7858.5 922.6 996.0 1051.0 1051.3 1073.7 30359.4 31470.2 31774.5 31841.2 32367.5 1016.5 1033.0 1067.0 1129.6 1138.3 14213.7 14294.6 14428.4 14445.7 14596.6 301514.0 305160.0 305622.0 305813.0 305829.0 48842.0 48930.3 49003.5 49065.5 49123.8 1191.6 1255.7 1359.6 1378.4 1472.6 25541.6 27558.0 27569.9 27618.4 28024.6 40981.6 41476.4 41647.0 41754.4 41880.8 181025.0 184305.1 304956.0 306049.0 309392.0 29386.3 29528.0 29569.9 29571.4 29602.9 38552.4 39472.0 39532.2 39844.4 39958.6 32412.8 33019.0 33375.8 33765.7 34020.5 34708.3 35285.3 36302.5 36392.3 36446.3 32463.0 32689.7 32845.5 33010.7 35823.1 27169.2 28551.7 30927.7 31728.4 31749.5 24516.6 24950.0 24996.9 25088.4 25347.4 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | [#2] jquery.html Cycles:180 Average:26677.35 Median:17832.26 stddev:82955.49 (465.2%) stddev-sans-first:83164.65 20:20:05 INFO - PROCESS | 13758 | Values: 352.3 352.9 355.9 357.7 359.5 14188.7 14236.0 16420.7 17027.8 18181.3 13764.6 14406.3 14696.6 14698.9 14706.5 5340.0 5463.5 5465.2 5466.6 5477.1 4135.6 4200.0 5408.1 5427.2 6038.9 6052.5 6098.5 6125.4 6134.0 6141.6 5355.7 5513.8 5514.4 5516.6 6089.8 5126.8 5288.6 5295.6 5303.4 5304.0 12518.2 12702.3 12718.5 12728.9 16819.7 1966.7 2049.4 2075.2 2132.0 2170.7 9889.1 11352.5 12398.2 12712.9 13207.1 1732.0 1826.4 1845.6 1858.6 1917.7 56842.0 59530.0 61060.4 61210.0 61865.4 10357.5 10374.5 10423.8 10487.7 10554.6 13524.5 13530.8 13542.9 13564.8 13581.5 6494.9 6500.2 6500.8 6607.8 6705.5 5811.6 5846.9 5888.6 5894.0 5907.0 4498.0 4531.2 4537.3 4585.8 4611.6 1770.9 1818.9 1824.5 1831.5 1842.9 917.9 936.0 990.4 1016.3 1020.8 16186.8 16886.8 17013.3 17357.7 17464.1 903.1 923.2 925.8 938.0 970.2 8975.3 9821.3 9890.2 9893.4 9978.5 420250.0 423172.0 556467.0 560149.0 562458.0 41440.2 42004.6 45285.5 67951.7 69828.7 1126.2 1132.8 1141.9 1147.4 1155.4 15623.0 15800.1 15901.9 15940.0 16164.9 19844.7 25306.7 26194.2 35311.6 35404.1 45930.3 46179.0 46617.0 47640.3 47865.8 9571.8 9595.3 9676.9 9712.8 9780.9 16608.7 16648.8 16936.1 17387.8 17566.3 10945.3 13763.4 14076.4 14337.7 14362.7 13625.5 13671.7 13724.2 14038.5 14227.9 13769.1 14222.9 14259.2 14542.5 14651.4 8699.1 8887.9 8895.1 9026.5 9045.1 10764.6 14575.5 14576.9 14878.2 14955.5 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | [#3] mootools.html Cycles:180 Average:5404.43 Median:6412.54 stddev:2827.76 (44.1%) stddev-sans-first:2819.05 20:20:05 INFO - PROCESS | 13758 | Values: 1323.2 1502.9 1503.7 1658.8 1808.1 6961.2 7635.9 7741.1 7749.7 7751.0 7509.8 7674.8 7692.3 7693.4 7695.9 2002.2 2030.2 2032.3 2263.7 2311.2 2032.9 2247.3 2269.2 2278.5 2281.5 2177.5 2217.7 2218.2 2221.1 2291.2 2265.4 2281.0 2294.4 2296.7 2299.4 2218.3 2261.2 2262.9 2263.2 2270.5 7618.4 7703.3 7704.4 7706.0 7706.3 4430.3 4476.8 4502.9 4504.4 4505.8 2957.8 3093.7 3094.0 3117.4 3117.8 955.2 977.6 980.4 1013.6 1049.1 10663.9 10664.6 10667.1 10685.1 10696.3 4216.9 4227.1 4253.8 4274.3 4276.5 9146.5 9153.9 9168.1 9172.5 9173.9 4625.7 4629.1 4631.3 4633.4 4633.8 4184.1 4185.5 4193.3 4196.8 4201.5 3359.2 3553.3 3608.1 3640.7 3655.3 1091.2 1129.7 1154.8 1157.8 1169.9 1023.8 1023.8 1069.9 1183.8 1355.7 6385.0 6445.0 6456.3 6466.9 6469.5 1000.8 1015.0 1018.6 1024.3 1024.3 5664.9 5717.2 5759.9 5769.0 5770.6 8975.2 9369.9 9471.2 9479.8 9485.7 9241.0 9312.6 9330.1 9367.7 9387.8 7140.9 7227.0 7227.2 7290.2 7300.6 7192.7 7255.7 7301.5 7306.7 7328.4 8293.8 8341.9 8554.0 8554.3 8554.8 8590.4 8805.6 8814.2 8815.0 8816.5 7095.5 7194.6 7195.2 7203.1 7206.9 6637.8 6900.1 7671.5 7717.4 7725.1 6884.3 6922.4 7002.4 7101.0 7146.7 6616.3 6695.6 6708.7 6821.6 6861.4 6822.7 6861.2 6862.7 6866.9 6868.3 6274.3 6354.9 6408.3 6416.8 6422.8 6515.7 6556.4 6565.8 6567.4 6569.6 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | [#4] prototype.html Cycles:180 Average:5312.26 Median:5939.27 stddev:1570.38 (26.4%) stddev-sans-first:1529.96 20:20:05 INFO - PROCESS | 13758 | Values: 348.7 351.9 352.6 352.7 355.2 5924.9 5928.5 5937.5 5948.8 5975.4 5636.4 5701.3 5772.8 5817.4 5897.6 4612.6 4632.8 4636.5 4647.8 4654.3 4617.1 4621.3 4622.7 4627.4 4636.0 4330.3 4401.3 4456.8 4594.7 4603.4 4579.7 4587.7 4595.5 4600.5 4611.5 4056.6 4066.5 4066.9 4067.9 4069.4 5542.1 5550.3 5555.6 5557.8 5559.0 5175.1 5342.0 5369.0 5393.5 5399.4 6211.2 6217.9 6224.9 6228.8 6229.6 4499.7 4507.6 4507.8 4509.9 4517.2 6391.4 6473.2 6548.3 6569.9 6578.7 4661.6 4661.9 4662.2 4669.9 4676.5 4732.6 4732.9 4735.9 4741.6 4744.7 5361.8 5364.9 5375.3 5376.2 5382.8 6173.5 6314.8 6328.1 6328.3 6346.1 1655.8 1676.4 1677.8 1677.8 1679.0 1143.3 1151.0 1152.0 1175.1 1176.3 5951.9 5958.5 5960.5 5961.0 5977.9 6468.9 6502.0 6509.8 6517.9 6519.4 5774.5 5803.3 5921.9 5941.0 5994.3 3495.3 3504.1 3510.2 3525.6 3529.3 6806.4 6815.6 6816.5 6898.3 6901.4 6622.0 6705.5 6732.4 6740.3 6749.0 6806.6 6817.2 6821.1 6823.1 6829.2 6551.3 6552.9 6561.7 6568.9 6569.8 6333.1 6462.5 6468.1 6473.1 6479.1 6796.6 6799.6 6804.0 6804.8 6808.5 4557.6 4570.4 4576.8 4585.8 4590.0 6385.9 6535.0 6542.7 6554.2 6559.4 6372.1 6372.6 6373.1 6375.6 6384.8 6352.1 6354.3 6354.7 6368.1 6370.4 6156.2 6203.9 6239.2 6256.4 6258.5 6389.6 6390.7 6392.3 6397.0 6397.8 6239.1 6245.2 6250.2 6251.4 6262.2 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - PROCESS | 13758 | [#5] yui.html Cycles:180 Average:13310.43 Median:46508.65 stddev:15171.54 (32.6%) stddev-sans-first:15184.70 20:20:05 INFO - PROCESS | 13758 | Values: 733.6 814.5 852.9 853.0 868.5 12283.5 12471.3 12474.9 12484.4 12502.4 11511.0 11961.2 11975.3 11983.9 11991.8 687.9 694.5 697.3 825.7 845.3 834.8 836.2 841.9 842.0 842.7 875.8 876.4 878.4 878.5 879.0 722.7 731.5 864.7 876.4 879.5 645.9 647.2 647.3 647.9 648.1 12192.0 12322.8 12325.8 12343.8 12346.3 12390.6 12501.4 12652.7 12924.3 13180.2 10576.8 10827.2 10831.7 11061.6 11204.0 3583.9 3587.9 3618.4 3618.8 3680.2 42697.1 46935.3 47110.8 47177.8 47235.8 9945.2 10081.2 10096.5 10200.4 10232.6 18002.5 18055.5 18080.8 18113.1 18169.8 6973.9 7146.8 7147.7 7156.7 7177.4 4257.2 4260.0 4273.8 4275.8 4277.6 3267.5 3295.0 3295.8 3307.0 3309.6 573.6 587.3 595.3 600.4 606.0 577.9 604.4 614.2 659.4 682.5 8683.1 8914.2 9077.9 9090.3 9090.6 547.6 570.0 698.7 699.9 729.2 3857.4 3873.9 4128.8 4204.2 4249.6 49140.8 49175.8 49184.5 49647.5 49757.5 45706.5 45883.5 45976.5 46517.5 52239.5 46371.3 46743.8 47721.5 48005.8 48086.0 7878.4 7880.7 8006.3 8031.8 8045.9 34627.3 35535.1 35702.5 35728.3 35858.3 43894.0 46242.8 46418.5 46474.5 46499.8 10358.9 10456.5 10512.7 10655.9 10726.8 11659.8 11798.1 11890.2 11930.5 11952.2 10631.3 10717.3 10863.5 10913.2 10930.1 10776.4 10822.4 10914.2 11075.8 11372.0 9595.9 9866.7 9964.4 10245.9 10275.7 9519.5 9595.3 9671.0 9721.8 9933.5 8830.2 9338.3 9369.2 9371.9 9385.2 20:20:05 INFO - PROCESS | 13758 | -------- Summary: end -------- 20:20:05 INFO - PROCESS | 13758 | 20:20:05 INFO - TEST-INFO | 13758: exit 0 20:20:06 INFO - TEST-OK | dromaeo_css | took 1112506ms 20:20:06 INFO - TEST-START | kraken 20:20:06 INFO - operating with platform_type : linux_ 20:20:06 INFO - Initialising browser for kraken test... 20:20:06 INFO - TEST-INFO | started process 13956 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzLE2P9/profile http://localhost:41747/getInfo.html) 20:20:10 INFO - PROCESS | 13956 | __metrics Screen width/height:1600/1200 20:20:10 INFO - PROCESS | 13956 | colorDepth:24 20:20:10 INFO - PROCESS | 13956 | Browser inner width/height: 1024/697 20:20:10 INFO - PROCESS | 13956 | __metrics 20:20:10 INFO - PROCESS | 13956 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:20:10 INFO - PROCESS | 13956 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:11 INFO - TEST-INFO | 13956: exit 0 20:20:11 INFO - Browser initialized. 20:20:11 INFO - Running cycle 1/1 for kraken test... 20:20:11 INFO - TEST-INFO | started process 14038 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzLE2P9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:23 INFO - PROCESS | 14038 | RSS: Main: 149618688 20:20:23 INFO - PROCESS | 14038 | 20:20:25 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41747/tests/kraken/driver.html?testName=audio-beat-detection) 20:20:26 INFO - PROCESS | 14038 | RSS: Main: 182829056 20:20:26 INFO - PROCESS | 14038 | 20:20:28 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41747/tests/kraken/driver.html?testName=audio-dft) 20:20:29 INFO - PROCESS | 14038 | RSS: Main: 173027328 20:20:29 INFO - PROCESS | 14038 | 20:20:32 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41747/tests/kraken/driver.html?testName=audio-fft) 20:20:32 INFO - PROCESS | 14038 | RSS: Main: 160317440 20:20:32 INFO - PROCESS | 14038 | 20:20:34 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41747/tests/kraken/driver.html?testName=audio-oscillator) 20:20:35 INFO - PROCESS | 14038 | RSS: Main: 163540992 20:20:35 INFO - PROCESS | 14038 | 20:20:37 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:20:38 INFO - PROCESS | 14038 | RSS: Main: 165748736 20:20:38 INFO - PROCESS | 14038 | 20:20:40 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41747/tests/kraken/driver.html?testName=imaging-darkroom) 20:20:41 INFO - PROCESS | 14038 | RSS: Main: 165978112 20:20:41 INFO - PROCESS | 14038 | 20:20:44 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41747/tests/kraken/driver.html?testName=imaging-desaturate) 20:20:45 INFO - PROCESS | 14038 | RSS: Main: 165138432 20:20:45 INFO - PROCESS | 14038 | 20:20:48 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41747/tests/kraken/driver.html?testName=json-parse-financial) 20:20:48 INFO - PROCESS | 14038 | RSS: Main: 165068800 20:20:48 INFO - PROCESS | 14038 | 20:20:50 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:20:50 INFO - PROCESS | 14038 | RSS: Main: 175681536 20:20:50 INFO - PROCESS | 14038 | 20:20:52 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:20:53 INFO - PROCESS | 14038 | RSS: Main: 173125632 20:20:53 INFO - PROCESS | 14038 | 20:20:55 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:20:55 INFO - PROCESS | 14038 | RSS: Main: 178544640 20:20:55 INFO - PROCESS | 14038 | 20:20:58 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:20:58 INFO - PROCESS | 14038 | RSS: Main: 189227008 20:20:58 INFO - PROCESS | 14038 | 20:21:01 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:21:02 INFO - PROCESS | 14038 | RSS: Main: 185724928 20:21:02 INFO - PROCESS | 14038 | 20:21:03 INFO - PROCESS | 14038 | Cycle 1(1): loaded http://localhost:41747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41747/tests/kraken/driver.html?testName=ai-astar) 20:21:04 INFO - PROCESS | 14038 | RSS: Main: 243830784 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | __start_tp_report 20:21:04 INFO - PROCESS | 14038 | _x_x_mozilla_page_load 20:21:04 INFO - PROCESS | 14038 | _x_x_mozilla_page_load_details 20:21:04 INFO - PROCESS | 14038 | |i|pagename|runs| 20:21:04 INFO - PROCESS | 14038 | |0;ai-astar;110;112;105;109;112;110;101;111;111;103 20:21:04 INFO - PROCESS | 14038 | |1;audio-beat-detection;154;128;152;177;128;151;152;124;166;127 20:21:04 INFO - PROCESS | 14038 | |2;audio-dft;164;161;163;161;166;163;161;162;162;164 20:21:04 INFO - PROCESS | 14038 | |3;audio-fft;75;74;88;89;71;75;72;96;89;74 20:21:04 INFO - PROCESS | 14038 | |4;audio-oscillator;96;103;139;96;97;96;146;95;97;143 20:21:04 INFO - PROCESS | 14038 | |5;imaging-gaussian-blur;109;109;109;110;109;109;110;109;110;109 20:21:04 INFO - PROCESS | 14038 | |6;imaging-darkroom;146;145;146;146;146;146;144;146;146;145 20:21:04 INFO - PROCESS | 14038 | |7;imaging-desaturate;97;96;96;96;97;95;96;95;96;95 20:21:04 INFO - PROCESS | 14038 | |8;json-parse-financial;57;57;57;57;57;65;56;65;55;55 20:21:04 INFO - PROCESS | 14038 | |9;json-stringify-tinderbox;68;69;69;68;68;69;69;69;69;69 20:21:04 INFO - PROCESS | 14038 | |10;stanford-crypto-aes;88;88;88;89;91;85;86;86;88;87 20:21:04 INFO - PROCESS | 14038 | |11;stanford-crypto-ccm;127;116;115;117;129;125;119;127;117;116 20:21:04 INFO - PROCESS | 14038 | |12;stanford-crypto-pbkdf2;142;153;151;153;150;141;141;151;162;148 20:21:04 INFO - PROCESS | 14038 | |13;stanford-crypto-sha256-iterative;69;68;70;68;69;67;69;69;68;69 20:21:04 INFO - PROCESS | 14038 | __end_tp_report 20:21:04 INFO - PROCESS | 14038 | __start_cc_report 20:21:04 INFO - PROCESS | 14038 | _x_x_mozilla_cycle_collect,927 20:21:04 INFO - PROCESS | 14038 | __end_cc_report 20:21:04 INFO - PROCESS | 14038 | __startTimestamp1451622064018__endTimestamp 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | ------- Summary: start ------- 20:21:04 INFO - PROCESS | 14038 | Number of tests: 14 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:3.95 (3.6%) stddev-sans-first:4.15 20:21:04 INFO - PROCESS | 14038 | Values: 110.0 112.0 105.0 109.0 112.0 110.0 101.0 111.0 111.0 103.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:152.00 stddev:18.30 (12.0%) stddev-sans-first:19.18 20:21:04 INFO - PROCESS | 14038 | Values: 154.0 128.0 152.0 177.0 128.0 151.0 152.0 124.0 166.0 127.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.64 (1.0%) stddev-sans-first:1.67 20:21:04 INFO - PROCESS | 14038 | Values: 164.0 161.0 163.0 161.0 166.0 163.0 161.0 162.0 162.0 164.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#3] audio-fft Cycles:10 Average:80.30 Median:81.50 stddev:9.12 (11.2%) stddev-sans-first:9.47 20:21:04 INFO - PROCESS | 14038 | Values: 75.0 74.0 88.0 89.0 71.0 75.0 72.0 96.0 89.0 74.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:96.00 stddev:22.16 (23.1%) stddev-sans-first:22.85 20:21:04 INFO - PROCESS | 14038 | Values: 96.0 103.0 139.0 96.0 97.0 96.0 146.0 95.0 97.0 143.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:21:04 INFO - PROCESS | 14038 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 20:21:04 INFO - PROCESS | 14038 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 144.0 146.0 146.0 145.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 20:21:04 INFO - PROCESS | 14038 | Values: 97.0 96.0 96.0 96.0 97.0 95.0 96.0 95.0 96.0 95.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.00 stddev:3.73 (6.5%) stddev-sans-first:3.93 20:21:04 INFO - PROCESS | 14038 | Values: 57.0 57.0 57.0 57.0 57.0 65.0 56.0 65.0 55.0 55.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 20:21:04 INFO - PROCESS | 14038 | Values: 68.0 69.0 69.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:1.71 (1.9%) stddev-sans-first:1.81 20:21:04 INFO - PROCESS | 14038 | Values: 88.0 88.0 88.0 89.0 91.0 85.0 86.0 86.0 88.0 87.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.00 stddev:5.51 (4.5%) stddev-sans-first:5.37 20:21:04 INFO - PROCESS | 14038 | Values: 127.0 116.0 115.0 117.0 129.0 125.0 119.0 127.0 117.0 116.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:151.00 stddev:6.56 (4.3%) stddev-sans-first:6.42 20:21:04 INFO - PROCESS | 14038 | Values: 142.0 153.0 151.0 153.0 150.0 141.0 141.0 151.0 162.0 148.0 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - PROCESS | 14038 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 20:21:04 INFO - PROCESS | 14038 | Values: 69.0 68.0 70.0 68.0 69.0 67.0 69.0 69.0 68.0 69.0 20:21:04 INFO - PROCESS | 14038 | -------- Summary: end -------- 20:21:04 INFO - PROCESS | 14038 | 20:21:04 INFO - TEST-INFO | 14038: exit 0 20:21:04 INFO - TEST-OK | kraken | took 58916ms 20:21:04 INFO - TEST-START | v8_7 20:21:04 INFO - operating with platform_type : linux_ 20:21:04 INFO - Initialising browser for v8_7 test... 20:21:04 INFO - TEST-INFO | started process 14287 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSz7loG/profile http://localhost:41747/getInfo.html) 20:21:08 INFO - PROCESS | 14287 | __metrics Screen width/height:1600/1200 20:21:08 INFO - PROCESS | 14287 | colorDepth:24 20:21:08 INFO - PROCESS | 14287 | Browser inner width/height: 1024/697 20:21:08 INFO - PROCESS | 14287 | __metrics 20:21:08 INFO - PROCESS | 14287 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:21:08 INFO - PROCESS | 14287 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:21:09 INFO - TEST-INFO | 14287: exit 0 20:21:09 INFO - Browser initialized. 20:21:09 INFO - Running cycle 1/1 for v8_7 test... 20:21:09 INFO - TEST-INFO | started process 14372 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSz7loG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:21 INFO - PROCESS | 14372 | RSS: Main: 149938176 20:21:21 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | Cycle 1(1): loaded http://localhost:41747/tests/v8_7/run.html (next: http://localhost:41747/tests/v8_7/run.html) 20:21:43 INFO - PROCESS | 14372 | RSS: Main: 176103424 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | __start_tp_report 20:21:43 INFO - PROCESS | 14372 | _x_x_mozilla_page_load 20:21:43 INFO - PROCESS | 14372 | _x_x_mozilla_page_load_details 20:21:43 INFO - PROCESS | 14372 | |i|pagename|runs| 20:21:43 INFO - PROCESS | 14372 | |0;Richards;167.95431642593215 20:21:43 INFO - PROCESS | 14372 | |1;DeltaBlue;189.82536066818528 20:21:43 INFO - PROCESS | 14372 | |2;Encrypt;279.79854504756577 20:21:43 INFO - PROCESS | 14372 | |3;Decrypt;5181.347150259067 20:21:43 INFO - PROCESS | 14372 | |4;RayTrace;1126.126126126126 20:21:43 INFO - PROCESS | 14372 | |5;Earley;797.4481658692185 20:21:43 INFO - PROCESS | 14372 | |6;Boyer;12746.835443037975 20:21:43 INFO - PROCESS | 14372 | |7;RegExp;25425 20:21:43 INFO - PROCESS | 14372 | |8;Splay;565.9309564233164 20:21:43 INFO - PROCESS | 14372 | |9;NavierStokes;4835.748792270531 20:21:43 INFO - PROCESS | 14372 | __end_tp_report 20:21:43 INFO - PROCESS | 14372 | __startTimestamp1451622103321__endTimestamp 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | ------- Summary: start ------- 20:21:43 INFO - PROCESS | 14372 | Number of tests: 10 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 168.0 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#1] DeltaBlue Cycles:1 Average:189.83 Median:189.83 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 189.8 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 279.8 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 5181.3 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#4] RayTrace Cycles:1 Average:1126.13 Median:1126.13 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 1126.1 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 797.4 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#6] Boyer Cycles:1 Average:12746.84 Median:12746.84 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 12746.8 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 25425.0 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#8] Splay Cycles:1 Average:565.93 Median:565.93 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 565.9 20:21:43 INFO - PROCESS | 14372 | 20:21:43 INFO - PROCESS | 14372 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:21:43 INFO - PROCESS | 14372 | Values: 4835.7 20:21:43 INFO - PROCESS | 14372 | -------- Summary: end -------- 20:21:43 INFO - PROCESS | 14372 | 20:21:44 INFO - TEST-INFO | 14372: exit 0 20:21:44 INFO - TEST-OK | v8_7 | took 39193ms 20:21:44 INFO - SUITE-END | took 1210s 20:21:44 INFO - Completed test suite (00:20:10) 20:21:44 INFO - Working with test: dromaeo_css 20:21:44 INFO - Generating results file: dromaeo_css 20:21:44 INFO - Working with test: kraken 20:21:44 INFO - Generating results file: kraken 20:21:44 INFO - javascript benchmark 20:21:44 INFO - Working with test: v8_7 20:21:44 INFO - Generating results file: v8_7 20:21:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:21:44 INFO - process_Request line: dromaeo_css 6869.64 graph.html#tests=[[72,64,35]] 20:21:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:44 INFO - process_Request line: kraken 1511.90 graph.html#tests=[[232,64,35]] 20:21:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:44 INFO - process_Request line: v8_7 21031.04 graph.html#tests=[[230,64,35]] 20:21:44 INFO - RETURN: dromaeo_css: 6869.64 20:21:44 INFO - RETURN: kraken: 1511.90 20:21:44 INFO - RETURN: v8_7: 21031.04 20:21:44 INFO - javascript benchmark 20:21:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3070.6008218931543, 3160.494320908655, 3208.8074715517073, 3212.277237621534, 3239.1416274687213, 5156.92264616031, 5266.138165345414, 5271.6836989780595, 5272.209168624709, 5346.304980352558, 5180.3006594109875, 5242.292290540776, 5274.868128296785, 5277.208418737191, 5311.336082989626, 4866.707997520151, 4885.877853053685, 4903.509649035103, 4906.190478571031, 4969.105560999019, 4927.433345165316, 4977.303177555145, 5012.72430016349, 5020.246962955549, 5058.190689489682, 4749.857504274877, 4801.68789028712, 4858.5384388483035, 4925.581325587329, 4930.901381972359, 4883.267509873512, 4901.411830580318, 4904.60763138948, 4911.214205727067, 4917.0903382874285, 4840.75796210188, 4853.514648535153, 4866.756662166913, 4870.756462176877, 4892.681975671606, 5050.949490505084, 5134.0502007128425, 5188.844334669966, 5215.1134307167495, 5272.288241087481, 5598.552115830724, 5668.97165514174, 5735.741891614887, 5741.971290143564, 5754.136879468071, 5695.7152142392715, 5703.429657034305, 5725.198472213893, 5728.570357223225, 5732.684702341369, 5292.444293349181, 5293.894122117575, 5299.152135658276, 5301.151815709468, 5323.707196104213, 5632.662040277514, 5637.0, 5737.713114344266, 5766.394528574523, 5786.71066446676, 5510.448955104457, 5578.41426650204, 5579.609427340129, 5585.720713964367, 5616.438356164433, 5647.774089036392, 5649.096144616841, 5650.943490565041, 5651.321841379061, 5662.292213473316, 5514.283143191359, 5580.581456390787, 5590.776368945197, 5632.718364081861, 5635.802746903921, 5660.716964151776, 5668.688222147822, 5676.091825307931, 5690.2033715279895, 5701.942980570224, 4389.956100439019, 4392.538783427758, 4408.7575183365225, 4412.779361031936, 4434.357018232338, 3883.708721845873, 3884.028992751812, 3934.272159650474, 3959.4852669152824, 3960.9009774755286, 5284.656497327662, 5302.549283310885, 5311.415744268127, 5319.601029922694, 5348.893022139536, 5705.5435565154685, 5706.28671416073, 5706.657600543981, 5712.542996560265, 5728.942710572841, 5146.794128234904, 5227.973860130675, 5235.214717792362, 5253.44838791929, 5324.094903866352, 4855.587275081587, 4873.610111191168, 4884.3161957326, 4886.95113048865, 4947.975260123676, 5870.706464676835, 5879.617824841372, 5885.17607534954, 5886.0, 5913.172155898092, 5549.611527193219, 5604.411536788579, 5659.3491748447805, 5662.801801936913, 5790.710464476675, 5917.0, 5922.230110085661, 5926.259217597801, 5932.970335148297, 5942.702864856827, 5633.0705433603, 5658.094704847204, 5659.122835960433, 5659.292588426447, 5670.829875103754, 5567.331920169606, 5627.971860140673, 5649.406812284816, 5650.180723795109, 5728.341240757366, 5507.642003269774, 5547.55619550443, 5556.444355564573, 5565.6104072714525, 5591.049521581423, 5523.6409633373705, 5545.916811247916, 5547.389787123332, 5552.916706249491, 5591.972040139936, 5338.172583249602, 5381.1121165007335, 5414.539764120094, 5436.293281873332, 5500.80747173847, 5604.187392828098, 5611.3266408031295, 5615.213870058276, 5624.04391253496, 5675.517581005661, 5504.0, 5507.146392309199, 5508.0911649578975, 5508.283923089973, 5509.393966663583], "unit": "score", "name": "dojo.html", "value": 5243.378534565687}, {"lowerIsBetter": false, "replicates": [537.7230726176018, 584.1733946465752, 599.8470390050538, 600.4385899184263, 602.8794241151771, 27588.862055689744, 35816.641833581656, 35959.4606080909, 36090.09774755633, 36120.27759444816, 40581.7970910145, 41504.58495415052, 41542.0, 41564.0, 41594.58405415945, 7354.227806080365, 7453.068366454193, 8546.14538546145, 8783.47299162049, 8793.736187914374, 9949.75125621858, 10212.744681382988, 10222.182225421986, 10226.23303252259, 10236.590536378573, 9994.650187243411, 10111.191104711605, 10127.240456965721, 10134.189264858793, 10140.797184056315, 7550.584717840489, 7695.846083078363, 7708.306252437307, 7710.460267781257, 9902.653407130752, 10002.04980526856, 10198.541065651989, 10244.897551024469, 10246.333988290737, 10257.794844103151, 35713.46429803555, 35809.641903580894, 36060.459093113626, 36106.277874442625, 36107.0, 3253.251752097031, 3285.8849940251976, 3289.490129030004, 3381.7463690223085, 3385.86456541738, 27408.17775466719, 27991.440171196664, 28372.43255134886, 29791.0, 29887.551686724717, 3185.7132858042887, 3238.9676103239135, 3262.755293352984, 3268.934621307584, 3324.0526449961885, 263721.0, 263836.0, 263874.0, 264308.0, 264582.9999999981, 49842.501574983784, 50428.24357634639, 55175.44824551784, 55569.72215138898, 57215.71392143013, 53572.0, 53579.0, 53911.46088539065, 53966.46033539614, 54004.45995540073, 13877.097988630707, 13951.162930224218, 13966.301684915918, 14011.08927919682, 14038.087524310888, 9739.41563506192, 9740.172085372822, 9741.123298903132, 9745.31782775199, 9774.26692998028, 18489.7226541602, 19030.0, 19217.423477295702, 19227.134778934982, 19331.323403680803, 7517.361024312994, 7765.805854853674, 7820.217978202134, 7845.411594130463, 7858.528488290721, 922.6447817590276, 995.9800803983879, 1050.968470945873, 1051.332403923514, 1073.7476692977143, 30359.392812143633, 31470.1841165158, 31774.523382149287, 31841.203969900936, 32367.51448728271, 1016.5476363018386, 1033.0, 1066.983995240072, 1129.632869317475, 1138.3397629374942, 14213.715725685428, 14294.642633934234, 14428.350724217435, 14445.711085778226, 14596.635084122769, 301514.0, 305160.0, 305622.0, 305813.0, 305829.0, 48842.0, 48930.26604600934, 49003.50996490061, 49065.509344906095, 49123.75438122787, 1191.5769901684778, 1255.6860784803798, 1359.5649392194402, 1378.3935068569797, 1472.5729538433948, 25541.61687574725, 27558.0, 27569.86215068992, 27618.447631047668, 28024.57963130514, 40981.590184097775, 41476.37785433161, 41647.0, 41754.37368439537, 41880.79059604683, 181025.0, 184305.07847460677, 304956.0, 306049.0, 309392.0, 29386.265343366587, 29528.0, 29569.85215073911, 29571.408571828873, 29602.851985739933, 38552.42171367488, 39472.0, 39532.2093558133, 39844.40233396443, 39958.60041399549, 32412.837935811112, 33019.0, 33375.83312083424, 33765.66234337625, 34020.48969265413, 34708.305833882674, 35285.29429411449, 36302.455463168604, 36392.27215455729, 36446.27107457889, 32463.0, 32689.673103268662, 32845.50731739074, 33010.66989330076, 35823.104422389646, 27169.24836520037, 28551.714482854906, 30927.69072309248, 31728.365432690756, 31749.523757144125, 24516.632250516614, 24950.0, 24996.875015624806, 25088.37279067965, 25347.366315842253], "unit": "score", "name": "ext.html", "value": 17781.814442236308}, {"lowerIsBetter": false, "replicates": [352.3165059784019, 352.8729657323361, 355.90212691509834, 357.71561608521216, 359.4913197825078, 14188.71622567548, 14236.0, 16420.67158656826, 17027.82972170278, 18181.27280907863, 13764.587062388144, 14406.27968601571, 14696.55910322692, 14698.926505367459, 14706.48527301542, 5340.038793017265, 5463.48096930791, 5465.234867118606, 5466.644668096581, 5477.123660214366, 4135.565765594614, 4200.0339921818, 5408.0535906216255, 5427.240186373911, 6038.879222415549, 6052.485538729214, 6098.542609304298, 6125.387461253884, 6133.969330153365, 6141.600795948271, 5355.705436201008, 5513.8345849624375, 5514.420985796473, 5516.613837031409, 6089.81730548082, 5126.769295381717, 5288.550473209782, 5295.629305948585, 5303.443138470444, 5304.045271851065, 12518.186317889307, 12702.301373424458, 12718.473783146082, 12728.872711272861, 16819.747703784455, 1966.7148263501713, 2049.3749406431034, 2075.1803037800137, 2132.0405817382084, 2170.674398840171, 9889.109980101754, 11352.545898164064, 12398.194117382342, 12712.872871271355, 13207.075504714674, 1732.0, 1826.4429349048535, 1845.5865866115275, 1858.618983108473, 1917.7027560728109, 56842.0, 59530.0, 61060.389396105915, 61210.0, 61865.38134618641, 10357.533910974023, 10374.533146008447, 10423.843642345371, 10487.685369438928, 10554.577816887391, 13524.526641567498, 13530.797038044437, 13542.932285338708, 13564.796528052088, 13581.524646637321, 6494.935050649433, 6500.187476565429, 6500.837479062967, 6607.80176594703, 6705.4970877184405, 5811.56413268998, 5846.94153058464, 5888.617239879394, 5893.970530147321, 5907.0, 4497.955020449754, 4531.18438681034, 4537.319402089647, 4585.79363928624, 4611.631069514431, 1770.8848924819845, 1818.945431637053, 1824.5165031266724, 1831.542114471382, 1842.861785366076, 917.9311551633655, 935.9953200233955, 990.3958585262984, 1016.2733645443543, 1020.811149937264, 16186.75719864203, 16886.831131688527, 17013.319467221172, 17357.65284694299, 17464.126793660267, 903.1284810158229, 923.2014307623991, 925.8102089071724, 938.0197693410266, 970.1850445625568, 8975.28197744179, 9821.312508124363, 9890.20878329732, 9893.35693179941, 9978.501074946369, 420250.0, 423172.0, 556467.0, 560149.0, 562458.0, 41440.1711965759, 42004.57995420068, 45285.54714452879, 67951.66024169847, 69828.6508567464, 1126.1947707389256, 1132.8357388178667, 1141.937193454368, 1147.4320211495196, 1155.4049664422828, 15623.0, 15800.130992795046, 15901.920490397473, 15940.0, 16164.919175404048, 19844.70232946478, 25306.746932530437, 26194.214173574823, 35311.64688353083, 35404.052777096476, 45930.31104533368, 46179.0, 46617.0, 47640.2853957184, 47865.76067119642, 9571.808563828823, 9595.28035397334, 9676.9032309676, 9712.805743884941, 9780.902190977999, 16608.667826643643, 16648.750268746222, 16936.068516231724, 17387.82612173862, 17566.297348106444, 10945.288556243819, 13763.449462021406, 14076.366563504462, 14337.713245735236, 14362.712745745235, 13625.454981800616, 13671.690241121427, 13724.176549407068, 14038.508652197532, 14227.857721422653, 13769.105008174436, 14222.928885355506, 14259.215743134228, 14542.4910128145, 14651.413943442143, 8699.13008699125, 8887.911120888708, 8895.06601806801, 9026.503542304974, 9045.050269721585, 10764.569417223223, 14575.489857854924, 14576.927115364779, 14878.181700006604, 14955.476558320406], "unit": "score", "name": "jquery.html", "value": 8554.459347240761}, {"lowerIsBetter": false, "replicates": [1323.225912840988, 1502.9023113497624, 1503.6767095074556, 1658.7677725118479, 1808.1140241281769, 6961.164660240772, 7635.885461718071, 7741.071071471417, 7749.728759493419, 7751.0311211098615, 7509.812254693636, 7674.808129796744, 7692.3461505772075, 7693.422993275512, 7695.884561731565, 2002.1590931808603, 2030.1980717616532, 2032.2683833819813, 2263.7170353705787, 2311.1564279038116, 2032.9186832526682, 2247.314569056437, 2269.217120093573, 2278.498730279336, 2281.5094754627753, 2177.46652070243, 2217.6784366266884, 2218.201447478906, 2221.1115553778454, 2291.232437133562, 2265.365697604673, 2281.0305620111553, 2294.403455101677, 2296.724393072842, 2299.3906614747107, 2218.279059305732, 2261.2311813983324, 2262.857257085178, 2263.2418139923147, 2270.5345404192103, 7618.428617853628, 7703.3452156566755, 7704.383649308098, 7706.0, 7706.344960678349, 4430.29115341547, 4476.843310484118, 4502.909941801146, 4504.414426124616, 4505.797239124247, 2957.778166637511, 3093.7215650591556, 3093.9690603093904, 3117.423276693796, 3117.7817552771317, 955.159459675488, 977.6040703515088, 980.4068538534227, 1013.5844303835393, 1049.082053203447, 10663.946680266627, 10664.573417063308, 10667.14662826972, 10685.145188384911, 10696.251262411633, 4216.936745948752, 4227.112306415625, 4253.80857861397, 4274.337477690963, 4276.465441819772, 9146.451212927246, 9153.862692059625, 9168.083191680911, 9172.495512746864, 9173.908260917438, 4625.653076019312, 4629.1436084324505, 4631.282151266559, 4633.374494443275, 4633.7683115844075, 4184.121334519785, 4185.497740271187, 4193.287141185945, 4196.769177695195, 4201.537830838605, 3359.193793489545, 3553.2538166985223, 3608.1160115771804, 3640.7269454791, 3655.3054919565197, 1091.1652585771733, 1129.728865072393, 1154.7979103656826, 1157.8379026936236, 1169.900558452541, 1023.7850051489122, 1023.8464230365505, 1069.8716154061563, 1183.7632473505334, 1355.722076974218, 6385.0, 6444.967775161094, 6456.322086180978, 6466.870662586722, 6469.450096741735, 1000.7798284377425, 1014.9949250253701, 1018.6129270877168, 1024.2727663359099, 1024.3188279793853, 5664.85837854057, 5717.199592057115, 5759.94240057594, 5769.048107062372, 5770.596058275964, 8975.23710484603, 9369.859452108223, 9471.242300615933, 9479.810403791886, 9485.66800161991, 9240.95379523098, 9312.580933857857, 9330.066993300752, 9367.672131475365, 9387.812243755086, 7140.892886606705, 7226.963865180641, 7227.241139680258, 7290.161631412349, 7300.6349682515665, 7192.748253811301, 7255.673494692857, 7301.5031918455525, 7306.6711997959155, 7328.413726901942, 8293.751187464386, 8341.874871876806, 8554.0, 8554.27288680469, 8554.78613034679, 8590.35572332065, 8805.603747831236, 8814.162654547808, 8815.0, 8816.471011739317, 7095.538789978635, 7194.640267986684, 7195.208527062124, 7203.063601731741, 7206.855862882818, 6637.767678131242, 6900.137482814648, 7671.462997590115, 7717.382609391348, 7725.072991241087, 6884.345987131214, 6922.411595014279, 7002.404795592228, 7100.970359297976, 7146.678399471933, 6616.338366163345, 6695.564788288746, 6708.731650733916, 6821.624810635462, 6861.416779573592, 6822.727090916308, 6861.176658800976, 6862.691178897061, 6866.862662746817, 6868.347506986828, 6274.341194174546, 6354.90467642995, 6408.263049749338, 6416.807495775134, 6422.775202867877, 6515.706793194412, 6556.442702370352, 6565.835854103686, 6567.44176744982, 6569.638669873203], "unit": "score", "name": "mootools.html", "value": 4422.739870560466}, {"lowerIsBetter": false, "replicates": [348.66179805588575, 351.90322661268164, 352.6315000824139, 352.73721077797035, 355.2309250472725, 5924.881502369955, 5928.496077833384, 5937.495312898403, 5948.821535353935, 5975.43056485711, 5636.351819540754, 5701.34434540028, 5772.797952071678, 5817.360090390053, 5897.557683173758, 4612.561806628365, 4632.837850675227, 4636.4899861015265, 4647.790849411767, 4654.301854721785, 4617.07658468306, 4621.260598304272, 4622.699524530912, 4627.3521706961055, 4636.0, 4330.307150855863, 4401.339799030139, 4456.799444025027, 4594.74728889911, 4603.4015577974815, 4579.7481138537205, 4587.678862479628, 4595.494495605481, 4600.539946005372, 4611.492735799059, 4056.553779084298, 4066.451029111062, 4066.877993660195, 4067.918641627151, 4069.3895915612597, 5542.057850165482, 5550.27846379972, 5555.611107222496, 5557.833265002016, 5559.0, 5175.120229560946, 5341.973290133525, 5369.0, 5393.541548968343, 5399.379071406799, 6211.223597050369, 6217.937820621781, 6224.937750622526, 6228.844278893019, 6229.563930524865, 4499.662525310615, 4507.639388848885, 4507.842225522091, 4509.932351014738, 4517.2094883395275, 6391.392817682313, 6473.158489396395, 6548.312427195124, 6569.901451478232, 6578.671066446658, 4661.557152070548, 4661.883452913704, 4662.207424737802, 4669.929951050737, 4676.50896655853, 4732.574068333866, 4732.929006064912, 4735.857924262277, 4741.644376671763, 4744.691595046311, 5361.839144825662, 5364.946350536523, 5375.3280839895015, 5376.166694162411, 5382.811601593926, 6173.506119510428, 6314.8421289467215, 6328.082428047999, 6328.272248691367, 6346.143270658495, 1655.7847479827544, 1676.3964972609851, 1677.790276215473, 1677.8406051425095, 1679.0429455210658, 1143.3311512765126, 1151.027381862325, 1151.9827202591969, 1175.1421462332546, 1176.2824676947055, 5951.880962380728, 5958.493528050078, 5960.523158147338, 5961.01643228871, 5977.880442391128, 6468.935310646927, 6502.0, 6509.837254068591, 6517.9348206517325, 6519.4132528072705, 5774.480296773227, 5803.274590676166, 5921.851953701192, 5941.049432090845, 5994.310654274815, 3495.2834668892815, 3504.0714210734177, 3510.227749895019, 3525.576930768273, 3529.2764983178386, 6806.387425131762, 6815.625140617313, 6816.4546836252985, 6898.344657257552, 6901.378875901193, 6622.0, 6705.530612857151, 6732.427743641747, 6740.29226931175, 6749.0, 6806.557573757789, 6817.216020157646, 6821.147356580427, 6823.147106611674, 6829.18049834033, 6551.279359270572, 6552.868942621216, 6561.704723287368, 6568.901466477911, 6569.770058047945, 6333.081703152925, 6462.483001359786, 6468.094466774562, 6473.126127972663, 6479.125318082187, 6796.558223715443, 6799.558028728117, 6804.0, 6804.795856124324, 6808.489363297674, 4557.567031132037, 4570.360149578995, 4576.771161441981, 4585.770711464346, 4589.9541004590865, 6385.87228255423, 6534.987077003072, 6542.705578249085, 6554.246261679968, 6559.442447392025, 6372.0760489729655, 6372.55392122547, 6373.075903993802, 6375.649339286384, 6384.840378990377, 6352.078948552342, 6354.269259035085, 6354.745810167541, 6368.140301059298, 6370.426661600478, 6156.199694039746, 6203.937960620336, 6239.188905442264, 6256.436920677161, 6258.468030217483, 6389.616623002635, 6390.7443702251385, 6392.296847346881, 6397.0, 6397.808065758035, 6239.0953311768635, 6245.219347581552, 6250.249970003447, 6251.406116419115, 6262.185915830913], "unit": "score", "name": "prototype.html", "value": 4813.521439597025}, {"lowerIsBetter": false, "replicates": [733.5928559649395, 814.4950130918829, 852.9189726975939, 852.9530875801836, 868.5179725252482, 12283.508659653615, 12471.314077725721, 12474.875251247484, 12484.438200280998, 12502.374881255924, 11511.0, 11961.16271860968, 11975.341356225405, 11983.940080299608, 11991.820122698145, 687.9002544631026, 694.4791406445166, 697.2609034423502, 825.7357645553425, 845.344857735254, 834.7996480844583, 836.2056046755577, 841.869510225916, 842.0442797424905, 842.6671464771412, 875.8204568063531, 876.3865294293988, 878.4246318661287, 878.5299864572455, 879.0155026370473, 722.6639612580149, 731.4843035659848, 864.7059999600166, 876.4259410086404, 879.5030807593689, 645.8611398549288, 647.1910112359551, 647.2556559956041, 647.9449246814027, 648.1412128929188, 12191.963683086948, 12322.75354492914, 12325.815112773316, 12343.753124937452, 12346.320952347618, 12390.62828115149, 12501.437435315342, 12652.68368290791, 12924.289164095972, 13180.209187448689, 10576.788464230749, 10827.24209305349, 10831.67504974852, 11061.557537698482, 11204.0, 3583.87456439026, 3587.892363229107, 3618.4391419330045, 3618.8190590470635, 3680.190358121209, 42697.14605707899, 46935.295970560466, 47110.76444617755, 47177.764111179225, 47235.76382118102, 9945.20438364929, 10081.243906707026, 10096.495175241209, 10200.38797672142, 10232.64185753495, 18002.5499362517, 18055.54861128456, 18080.819191807914, 18113.094345282683, 18169.81830181708, 6973.895391569131, 7146.785596432115, 7147.678354473957, 7156.749513766993, 7177.354038136488, 4257.19113368459, 4260.0, 4273.786310684453, 4275.828966841354, 4277.615014648696, 3267.5262086997254, 3294.950575741366, 3295.846453741219, 3306.9503957440656, 3309.619393769699, 573.6357413042748, 587.3216435017562, 595.2886300870418, 600.3786081405812, 606.0454783715666, 577.9364269930304, 604.3774911840811, 614.2230078950132, 659.3867703036223, 682.4983637026781, 8683.131686831393, 8914.242289405343, 9077.863832042525, 9090.3212649653, 9090.636374544943, 547.5537436988841, 569.9658020518782, 698.6995591895534, 699.8705239530601, 729.1614643160408, 3857.3828187489867, 3873.9225215496094, 4128.814203360856, 4204.243236217449, 4249.617534421917, 49140.75429622829, 49175.75412122988, 49184.50815491871, 49647.50352496501, 49757.50242497529, 45706.54293457089, 45883.5411645886, 45976.540234597225, 46517.534824652, 52239.47760522346, 46371.30443043357, 46743.76628116838, 47721.5227847724, 48005.75997119992, 48086.0, 7878.4091193161885, 7880.724174653859, 8006.279434850659, 8031.839363212586, 8045.87931181021, 34627.30745385028, 35535.11162220965, 35702.4644630336, 35728.28543429169, 35858.28283434369, 43894.0, 46242.7687861572, 46418.535814642775, 46474.535254647024, 46499.76750116363, 10358.948205259227, 10456.529456174643, 10512.737181570523, 10655.86834817588, 10726.785464290515, 11659.825102623638, 11798.115141364604, 11890.227135236182, 11930.463129159381, 11952.163348565517, 10631.308964917256, 10717.303375280582, 10863.511141998471, 10913.181511386836, 10930.070943969533, 10776.353418794897, 10822.40476773785, 10914.23600347968, 11075.778484430428, 11372.0, 9595.856062158933, 9866.654667086617, 9964.352317099365, 10245.897541024495, 10275.7431064224, 9519.524023798644, 9595.328327017321, 9671.0, 9721.814061215737, 9933.453660048766, 8830.249428798625, 9338.299627528098, 9369.166109275304, 9371.85942210881, 9385.20225780789], "unit": "score", "name": "yui.html", "value": 6189.191002338855}], "name": "dromaeo_css", "value": 6869.643836427496}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 109.0, 112.0, 110.0, 101.0, 111.0, 111.0, 103.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 152.0, 177.0, 128.0, 151.0, 152.0, 124.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 163.0, 161.0, 166.0, 163.0, 161.0, 162.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 88.0, 89.0, 71.0, 75.0, 72.0, 96.0, 89.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [96.0, 103.0, 139.0, 96.0, 97.0, 96.0, 146.0, 95.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 144.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 65.0, 56.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 88.0, 89.0, 91.0, 85.0, 86.0, 86.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [127.0, 116.0, 115.0, 117.0, 129.0, 125.0, 119.0, 127.0, 117.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 151.0, 153.0, 150.0, 141.0, 141.0, 151.0, 162.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 70.0, 68.0, 69.0, 67.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1511.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [189.82536066818528], "unit": "score", "name": "DeltaBlue", "value": 348.30962399999987}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1126.126126126126], "unit": "score", "name": "RayTrace", "value": 657.110232}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [12746.835443037975], "unit": "score", "name": "Boyer", "value": 52.28458490566033}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [565.9309564233164], "unit": "score", "name": "Splay", "value": 143.99459700000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21031.03593630131}]} 20:21:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "21031.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1511.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6869.64"}}} 20:21:44 INFO - Return code: 0 20:21:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:21:44 INFO - # TBPL SUCCESS # 20:21:44 INFO - Running post-action listener: _resource_record_post_action 20:21:44 INFO - Running post-run listener: _resource_record_post_run 20:21:45 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544174080; Read time: 8; Write time: 594148 20:21:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235220992; Read time: 0; Write time: 319000 20:21:45 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308666368; Read time: 8; Write time: 275128 20:21:45 INFO - Running post-run listener: _upload_blobber_files 20:21:45 INFO - Blob upload gear active. 20:21:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:21:45 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 20:21:45 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'] 20:21:45 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 20:21:46 INFO - (blobuploader) - INFO - Open directory for files ... 20:21:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:21:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:21:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:47 INFO - (blobuploader) - INFO - Done attempting. 20:21:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:21:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:21:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:47 INFO - (blobuploader) - INFO - Done attempting. 20:21:47 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:47 INFO - Return code: 0 20:21:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:21:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0adeb76a9742057eff98ddd243eed8cb2d5dd1497e28d3a047fa1f213583465689d250503e59da9eacbf733281e14d0f2d9349b560e013a68e544c82b029926a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4aca5dcee5f66295d1076363bb945d42b2f0dc10ef580a90933496b9edf222057fc57a1aa122d1bd65c5d34e26233e584c00887737aa589df3db22e80e8a8d0a"} 20:21:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:21:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:21:47 INFO - Contents: 20:21:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0adeb76a9742057eff98ddd243eed8cb2d5dd1497e28d3a047fa1f213583465689d250503e59da9eacbf733281e14d0f2d9349b560e013a68e544c82b029926a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4aca5dcee5f66295d1076363bb945d42b2f0dc10ef580a90933496b9edf222057fc57a1aa122d1bd65c5d34e26233e584c00887737aa589df3db22e80e8a8d0a"} 20:21:47 INFO - Copying logs to upload dir... 20:21:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.638765 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-31 20:21:47.171257) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:47.176810) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0adeb76a9742057eff98ddd243eed8cb2d5dd1497e28d3a047fa1f213583465689d250503e59da9eacbf733281e14d0f2d9349b560e013a68e544c82b029926a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4aca5dcee5f66295d1076363bb945d42b2f0dc10ef580a90933496b9edf222057fc57a1aa122d1bd65c5d34e26233e584c00887737aa589df3db22e80e8a8d0a"} build_url:https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/OuJrATnRRUyHInGWFrqNEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0adeb76a9742057eff98ddd243eed8cb2d5dd1497e28d3a047fa1f213583465689d250503e59da9eacbf733281e14d0f2d9349b560e013a68e544c82b029926a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4aca5dcee5f66295d1076363bb945d42b2f0dc10ef580a90933496b9edf222057fc57a1aa122d1bd65c5d34e26233e584c00887737aa589df3db22e80e8a8d0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:47.202475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:47.202812) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451617830.762950-1056178510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 20:21:47.287411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 20:21:47.287728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 20:21:47.288064) ========= ========= Total master_lag: 0.24 =========