builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1452398364.48 results: success (0) buildid: 20160109173002 builduid: 70416134c16547eaae36721601f01b90 revision: c06ff2c95163d8c4eabdf80643b08b93c1b16718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.477771) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.478324) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.478653) ========= 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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006380 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.516641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.517007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.635790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.636068) ========= 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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014858 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.708720) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.709071) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.709491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.709823) ========= 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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 19:59:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 34.6M=0s 2016-01-09 19:59:25 (34.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166856 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.911969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.912310) ========= 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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063347 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.991604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.991992) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c06ff2c95163d8c4eabdf80643b08b93c1b16718 --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 c06ff2c95163d8c4eabdf80643b08b93c1b16718 --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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 19:59:25,296 truncating revision to first 12 chars 2016-01-09 19:59:25,296 Setting DEBUG logging. 2016-01-09 19:59:25,296 attempt 1/10 2016-01-09 19:59:25,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c06ff2c95163?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 19:59:25,541 unpacking tar archive at: fx-team-c06ff2c95163/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548558 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.557794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.558500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.569550) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.570199) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.571141) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-09 19:59:25.571785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:25 INFO - MultiFileLogger online at 20160109 19:59:25 in /builds/slave/test-pgo 19:59:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:59:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:59:25 INFO - {'append_to_log': False, 19:59:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:59:25 INFO - 'blob_upload_branch': 'Fx-Team', 19:59:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:59:25 INFO - 'branch': 'Fx-Team', 19:59:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:25 INFO - 'config_files': ('talos/linux_config.py',), 19:59:25 INFO - 'default_actions': ('clobber', 19:59:25 INFO - 'read-buildbot-config', 19:59:25 INFO - 'download-and-extract', 19:59:25 INFO - 'populate-webroot', 19:59:25 INFO - 'create-virtualenv', 19:59:25 INFO - 'install', 19:59:25 INFO - 'run-tests'), 19:59:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:25 INFO - 'download_minidump_stackwalk': True, 19:59:25 INFO - 'download_symbols': 'ondemand', 19:59:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:25 INFO - 'installer_path': 'installer.exe', 19:59:25 INFO - 'log_level': 'info', 19:59:25 INFO - 'log_name': 'talos', 19:59:25 INFO - 'log_to_console': True, 19:59:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:25 INFO - 'opt_config_files': (), 19:59:25 INFO - 'pip_index': False, 19:59:25 INFO - 'sps_profile': False, 19:59:25 INFO - 'sps_profile_interval': 0, 19:59:25 INFO - 'suite': 'dromaeojs-e10s', 19:59:25 INFO - 'system_bits': '32', 19:59:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:25 INFO - 'title': 'talos-linux64-ix-050', 19:59:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:25 INFO - 'use_talos_json': True, 19:59:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:59:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:25 INFO - 'work_dir': 'build'} 19:59:25 INFO - ##### 19:59:25 INFO - ##### Running clobber step. 19:59:25 INFO - ##### 19:59:25 INFO - Running pre-action listener: _resource_record_pre_action 19:59:25 INFO - Running main action method: clobber 19:59:25 INFO - rmtree: /builds/slave/test-pgo/build 19:59:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:59:27 INFO - Running post-action listener: _resource_record_post_action 19:59:27 INFO - ##### 19:59:27 INFO - ##### Running read-buildbot-config step. 19:59:27 INFO - ##### 19:59:27 INFO - Running pre-action listener: _resource_record_pre_action 19:59:27 INFO - Running main action method: read_buildbot_config 19:59:27 INFO - Using buildbot properties: 19:59:27 INFO - { 19:59:27 INFO - "project": "", 19:59:27 INFO - "product": "firefox", 19:59:27 INFO - "script_repo_revision": "production", 19:59:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:59:27 INFO - "repository": "", 19:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:59:27 INFO - "buildid": "20160109173002", 19:59:27 INFO - "pgo_build": "True", 19:59:27 INFO - "basedir": "/builds/slave/test-pgo", 19:59:27 INFO - "buildnumber": 434, 19:59:27 INFO - "slavename": "talos-linux64-ix-050", 19:59:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:59:27 INFO - "platform": "ubuntu64_hw", 19:59:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:59:27 INFO - "branch": "fx-team", 19:59:27 INFO - "repo_path": "integration/fx-team", 19:59:27 INFO - "revision": "c06ff2c95163d8c4eabdf80643b08b93c1b16718", 19:59:27 INFO - "stage_platform": "linux64-pgo", 19:59:27 INFO - "builduid": "70416134c16547eaae36721601f01b90", 19:59:27 INFO - "slavebuilddir": "test" 19:59:27 INFO - } 19:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:59:27 INFO - Running post-action listener: _resource_record_post_action 19:59:27 INFO - ##### 19:59:27 INFO - ##### Running download-and-extract step. 19:59:27 INFO - ##### 19:59:27 INFO - Running pre-action listener: _resource_record_pre_action 19:59:27 INFO - Running main action method: download_and_extract 19:59:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:27 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json 19:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json 19:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:59:29 INFO - Downloaded 1302 bytes. 19:59:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:59:29 INFO - Using the following test package requirements: 19:59:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:29 INFO - u'jsshell-linux-x86_64.zip'], 19:59:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:59:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:59:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59:29 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')]} 19:59:29 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:31 INFO - Downloaded 24028339 bytes. 19:59:31 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 19:59:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:31 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 19:59:32 INFO - Return code: 0 19:59:32 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 19:59: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')]} 19:59:32 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:43 INFO - Downloaded 24028339 bytes. 19:59:43 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 19:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:43 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 19:59:44 INFO - Return code: 0 19:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:44 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:45 INFO - Downloaded 11132285 bytes. 19:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:59:45 INFO - Return code: 0 19:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:45 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:59:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/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 19:59:48 INFO - Downloaded 55924901 bytes. 19:59:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:48 INFO - mkdir: /builds/slave/test-pgo/properties 19:59:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:59:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:59:48 INFO - Contents: 19:59:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:48 INFO - Running post-action listener: _resource_record_post_action 19:59:48 INFO - Running post-action listener: set_extra_try_arguments 19:59:48 INFO - ##### 19:59:48 INFO - ##### Running populate-webroot step. 19:59:48 INFO - ##### 19:59:48 INFO - Running pre-action listener: _resource_record_pre_action 19:59:48 INFO - Running main action method: populate_webroot 19:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:48 INFO - '--tppagecycles', 19:59:48 INFO - '7'], 19:59:48 INFO - 'tests': ['tsvgm']}}, 19:59:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:59:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['damp', 'tps']}, 19:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['damp', 'tps']}, 19:59:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:48 INFO - 'other': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other_l64': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other_nol64': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'svgr': {'tests': ['tsvgx', 19:59:48 INFO - 'tsvgr_opacity', 19:59:48 INFO - 'tart', 19:59:48 INFO - 'tscrollx', 19:59:48 INFO - 'cart']}, 19:59:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tsvgx', 19:59:48 INFO - 'tsvgr_opacity', 19:59:48 INFO - 'tart', 19:59:48 INFO - 'tscrollx', 19:59:48 INFO - 'cart']}, 19:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['tp5o']}, 19:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tp5o']}, 19:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--xperf_path', 19:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:48 INFO - 'tests': ['tp5n']}, 19:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s', 19:59:48 INFO - '--xperf_path', 19:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:48 INFO - 'tests': ['tp5n']}}, 19:59:48 INFO - 'talos.zip': {'path': '', 19:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:48 INFO - Running post-action listener: _resource_record_post_action 19:59:48 INFO - ##### 19:59:48 INFO - ##### Running create-virtualenv step. 19:59:48 INFO - ##### 19:59:48 INFO - Running pre-action listener: _resource_record_pre_action 19:59:48 INFO - Running main action method: create_virtualenv 19:59:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:59:48 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 19:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:48 INFO - Using real prefix '/usr' 19:59:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:50 INFO - Installing pip.................done. 19:59:50 INFO - Return code: 0 19:59:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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 19:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:59:50 INFO - Using env: {'DISPLAY': ':0', 19:59:50 INFO - 'HOME': '/home/cltbld', 19:59:50 INFO - 'LANG': 'en_US.UTF-8', 19:59:50 INFO - 'LANGUAGE': 'en_US:en', 19:59:50 INFO - 'LOGNAME': 'cltbld', 19:59:50 INFO - 'MAIL': '/var/mail/cltbld', 19:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:50 INFO - 'MOZ_NO_REMOTE': '1', 19:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:50 INFO - 'NO_EM_RESTART': '1', 19:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:50 INFO - 'SHELL': '/bin/bash', 19:59:50 INFO - 'SHLVL': '1', 19:59:50 INFO - 'TERM': 'linux', 19:59:50 INFO - 'TMOUT': '86400', 19:59:50 INFO - 'USER': 'cltbld', 19:59:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 19:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:50 INFO - '_': '/tools/buildbot/bin/python'} 19:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:59:50 INFO - Cleaning up... 19:59:50 INFO - Return code: 0 19:59:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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 19:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:59:50 INFO - Using env: {'DISPLAY': ':0', 19:59:50 INFO - 'HOME': '/home/cltbld', 19:59:50 INFO - 'LANG': 'en_US.UTF-8', 19:59:50 INFO - 'LANGUAGE': 'en_US:en', 19:59:50 INFO - 'LOGNAME': 'cltbld', 19:59:50 INFO - 'MAIL': '/var/mail/cltbld', 19:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:50 INFO - 'MOZ_NO_REMOTE': '1', 19:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:50 INFO - 'NO_EM_RESTART': '1', 19:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:50 INFO - 'SHELL': '/bin/bash', 19:59:50 INFO - 'SHLVL': '1', 19:59:50 INFO - 'TERM': 'linux', 19:59:50 INFO - 'TMOUT': '86400', 19:59:50 INFO - 'USER': 'cltbld', 19:59:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 19:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:50 INFO - '_': '/tools/buildbot/bin/python'} 19:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:51 INFO - Downloading/unpacking psutil>=0.7.1 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:59:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:52 INFO - Installing collected packages: psutil 19:59:52 INFO - Running setup.py install for psutil 19:59:52 INFO - building 'psutil._psutil_linux' extension 19:59:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:59:53 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 19:59:53 INFO - building 'psutil._psutil_posix' extension 19:59:53 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 19:59:53 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 19:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:53 INFO - Successfully installed psutil 19:59:53 INFO - Cleaning up... 19:59:53 INFO - Return code: 0 19:59:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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 19:59:53 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 19:59:53 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 19:59:53 INFO - Using env: {'DISPLAY': ':0', 19:59:53 INFO - 'HOME': '/home/cltbld', 19:59:53 INFO - 'LANG': 'en_US.UTF-8', 19:59:53 INFO - 'LANGUAGE': 'en_US:en', 19:59:53 INFO - 'LOGNAME': 'cltbld', 19:59:53 INFO - 'MAIL': '/var/mail/cltbld', 19:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:53 INFO - 'MOZ_NO_REMOTE': '1', 19:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:53 INFO - 'NO_EM_RESTART': '1', 19:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:53 INFO - 'SHELL': '/bin/bash', 19:59:53 INFO - 'SHLVL': '1', 19:59:53 INFO - 'TERM': 'linux', 19:59:53 INFO - 'TMOUT': '86400', 19:59:53 INFO - 'USER': 'cltbld', 19:59:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 19:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:53 INFO - '_': '/tools/buildbot/bin/python'} 19:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:53 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 19:59:53 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 19:59:53 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 19:59:53 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 19:59:53 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 19:59:53 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 19:59:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:59:55 INFO - Installing collected packages: mozsystemmonitor 19:59:55 INFO - Running setup.py install for mozsystemmonitor 19:59:55 INFO - Successfully installed mozsystemmonitor 19:59:55 INFO - Cleaning up... 19:59:56 INFO - Return code: 0 19:59:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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', '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 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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 19:59: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:59: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 blobuploader==1.2.4 19:59:56 INFO - Using env: {'DISPLAY': ':0', 19:59:56 INFO - 'HOME': '/home/cltbld', 19:59:56 INFO - 'LANG': 'en_US.UTF-8', 19:59:56 INFO - 'LANGUAGE': 'en_US:en', 19:59:56 INFO - 'LOGNAME': 'cltbld', 19:59:56 INFO - 'MAIL': '/var/mail/cltbld', 19:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:56 INFO - 'MOZ_NO_REMOTE': '1', 19:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:56 INFO - 'NO_EM_RESTART': '1', 19:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:56 INFO - 'SHELL': '/bin/bash', 19:59:56 INFO - 'SHLVL': '1', 19:59:56 INFO - 'TERM': 'linux', 19:59:56 INFO - 'TMOUT': '86400', 19:59:56 INFO - 'USER': 'cltbld', 19:59:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 19:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:56 INFO - '_': '/tools/buildbot/bin/python'} 19:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:58 INFO - Downloading docopt-0.6.1.tar.gz 19:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:58 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:58 INFO - Running setup.py install for blobuploader 19:59:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:58 INFO - Running setup.py install for requests 19:59:59 INFO - Running setup.py install for docopt 19:59:59 INFO - Successfully installed blobuploader requests docopt 19:59:59 INFO - Cleaning up... 19:59:59 INFO - Return code: 0 19:59:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:59 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 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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 19:59:59 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 19:59:59 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 19:59:59 INFO - Using env: {'DISPLAY': ':0', 19:59:59 INFO - 'HOME': '/home/cltbld', 19:59:59 INFO - 'LANG': 'en_US.UTF-8', 19:59:59 INFO - 'LANGUAGE': 'en_US:en', 19:59:59 INFO - 'LOGNAME': 'cltbld', 19:59:59 INFO - 'MAIL': '/var/mail/cltbld', 19:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:59 INFO - 'MOZ_NO_REMOTE': '1', 19:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:59 INFO - 'NO_EM_RESTART': '1', 19:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:59 INFO - 'SHELL': '/bin/bash', 19:59:59 INFO - 'SHLVL': '1', 19:59:59 INFO - 'TERM': 'linux', 19:59:59 INFO - 'TMOUT': '86400', 19:59:59 INFO - 'USER': 'cltbld', 19:59:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 19:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:59 INFO - '_': '/tools/buildbot/bin/python'} 19:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:59 INFO - Running setup.py (path:/tmp/pip-1CqsJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:59 INFO - Running setup.py (path:/tmp/pip-m5fMxW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:59 INFO - Running setup.py (path:/tmp/pip-RW1Fuk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:59 INFO - Running setup.py (path:/tmp/pip-SXBv_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:59 INFO - Running setup.py (path:/tmp/pip-cK_JBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:00 INFO - Running setup.py (path:/tmp/pip-sM46k9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:00 INFO - Running setup.py (path:/tmp/pip-C76fAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:00 INFO - Running setup.py (path:/tmp/pip-opQIUP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:00 INFO - Running setup.py (path:/tmp/pip-2etQWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:00 INFO - Running setup.py (path:/tmp/pip-5G3y12-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:00 INFO - Running setup.py (path:/tmp/pip-EBVyKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:00 INFO - Running setup.py (path:/tmp/pip-lQWfr5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:00 INFO - Running setup.py (path:/tmp/pip-WBwdxj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:00 INFO - Running setup.py (path:/tmp/pip-xWsXKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:00 INFO - Running setup.py (path:/tmp/pip-neM9ZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:00 INFO - Running setup.py (path:/tmp/pip-cdtn_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:00 INFO - Running setup.py (path:/tmp/pip-zTh4Ze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:00:00 INFO - Running setup.py install for manifestparser 20:00:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:00:00 INFO - Running setup.py install for mozcrash 20:00:01 INFO - Running setup.py install for mozdebug 20:00:01 INFO - Running setup.py install for mozdevice 20:00:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Running setup.py install for mozfile 20:00:01 INFO - Running setup.py install for mozhttpd 20:00:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Running setup.py install for mozinfo 20:00:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Running setup.py install for mozInstall 20:00:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Running setup.py install for mozleak 20:00:01 INFO - Running setup.py install for mozlog 20:00:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Running setup.py install for moznetwork 20:00:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:00:01 INFO - Running setup.py install for mozprocess 20:00:02 INFO - Running setup.py install for mozprofile 20:00:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:00:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:00:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:00:02 INFO - Running setup.py install for mozrunner 20:00:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:00:02 INFO - Running setup.py install for mozscreenshot 20:00:02 INFO - Running setup.py install for moztest 20:00:02 INFO - Running setup.py install for mozversion 20:00:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:00:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:00:02 INFO - Cleaning up... 20:00:02 INFO - Return code: 0 20:00:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 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 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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:02 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:00:02 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:00:02 INFO - Using env: {'DISPLAY': ':0', 20:00:02 INFO - 'HOME': '/home/cltbld', 20:00:02 INFO - 'LANG': 'en_US.UTF-8', 20:00:02 INFO - 'LANGUAGE': 'en_US:en', 20:00:02 INFO - 'LOGNAME': 'cltbld', 20:00:02 INFO - 'MAIL': '/var/mail/cltbld', 20:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:02 INFO - 'MOZ_NO_REMOTE': '1', 20:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:02 INFO - 'NO_EM_RESTART': '1', 20:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:02 INFO - 'SHELL': '/bin/bash', 20:00:02 INFO - 'SHLVL': '1', 20:00:02 INFO - 'TERM': 'linux', 20:00:02 INFO - 'TMOUT': '86400', 20:00:02 INFO - 'USER': 'cltbld', 20:00:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 20:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:02 INFO - '_': '/tools/buildbot/bin/python'} 20:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:02 INFO - Running setup.py (path:/tmp/pip-C_nTdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:02 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:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:02 INFO - Running setup.py (path:/tmp/pip-Y4dli8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:03 INFO - Running setup.py (path:/tmp/pip-T0suNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:03 INFO - Running setup.py (path:/tmp/pip-tYa4nO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:03 INFO - Running setup.py (path:/tmp/pip-bkZEeZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:03 INFO - Running setup.py (path:/tmp/pip-v7mDd7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:03 INFO - Running setup.py (path:/tmp/pip-SSBXoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:03 INFO - Running setup.py (path:/tmp/pip-f2sBJL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:03 INFO - Running setup.py (path:/tmp/pip-yPZTm6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:03 INFO - Running setup.py (path:/tmp/pip-2UBY7i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:03 INFO - Running setup.py (path:/tmp/pip-uteFLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:03 INFO - Running setup.py (path:/tmp/pip-lrHzq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:03 INFO - Running setup.py (path:/tmp/pip-a9Mrpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:03 INFO - Running setup.py (path:/tmp/pip-HjJEZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:03 INFO - Running setup.py (path:/tmp/pip-wWiJBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:03 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:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:03 INFO - Running setup.py (path:/tmp/pip-rb9bOX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:04 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:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:04 INFO - Running setup.py (path:/tmp/pip-zxldys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:04 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:04 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:04 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:04 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:04 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:04 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:05 INFO - Downloading blessings-1.5.1.tar.gz 20:00:05 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:00:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:05 INFO - Installing collected packages: blessings 20:00:05 INFO - Running setup.py install for blessings 20:00:05 INFO - Successfully installed blessings 20:00:05 INFO - Cleaning up... 20:00:06 INFO - Return code: 0 20:00:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:00:06 INFO - Reading from file tmpfile_stdout 20:00:06 INFO - Current package versions: 20:00:06 INFO - argparse == 1.2.1 20:00:06 INFO - blessings == 1.5.1 20:00:06 INFO - blobuploader == 1.2.4 20:00:06 INFO - docopt == 0.6.1 20:00:06 INFO - manifestparser == 1.1 20:00:06 INFO - mozInstall == 1.12 20:00:06 INFO - mozcrash == 0.16 20:00:06 INFO - mozdebug == 0.1 20:00:06 INFO - mozdevice == 0.47 20:00:06 INFO - mozfile == 1.2 20:00:06 INFO - mozhttpd == 0.7 20:00:06 INFO - mozinfo == 0.9 20:00:06 INFO - mozleak == 0.1 20:00:06 INFO - mozlog == 3.1 20:00:06 INFO - moznetwork == 0.27 20:00:06 INFO - mozprocess == 0.22 20:00:06 INFO - mozprofile == 0.28 20:00:06 INFO - mozrunner == 6.11 20:00:06 INFO - mozscreenshot == 0.1 20:00:06 INFO - mozsystemmonitor == 0.0 20:00:06 INFO - moztest == 0.7 20:00:06 INFO - mozversion == 1.4 20:00:06 INFO - psutil == 3.1.1 20:00:06 INFO - requests == 1.2.3 20:00:06 INFO - wsgiref == 0.1.2 20:00:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:06 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 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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:06 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:00:06 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:00:06 INFO - Using env: {'DISPLAY': ':0', 20:00:06 INFO - 'HOME': '/home/cltbld', 20:00:06 INFO - 'LANG': 'en_US.UTF-8', 20:00:06 INFO - 'LANGUAGE': 'en_US:en', 20:00:06 INFO - 'LOGNAME': 'cltbld', 20:00:06 INFO - 'MAIL': '/var/mail/cltbld', 20:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:06 INFO - 'MOZ_NO_REMOTE': '1', 20:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:06 INFO - 'NO_EM_RESTART': '1', 20:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:06 INFO - 'SHELL': '/bin/bash', 20:00:06 INFO - 'SHLVL': '1', 20:00:06 INFO - 'TERM': 'linux', 20:00:06 INFO - 'TMOUT': '86400', 20:00:06 INFO - 'USER': 'cltbld', 20:00:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 20:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:06 INFO - '_': '/tools/buildbot/bin/python'} 20:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:06 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:00:06 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:00:06 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:00:06 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:00:06 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:00:06 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:00:06 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:00:06 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:00:06 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:00:06 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:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:00:06 INFO - Cleaning up... 20:00:06 INFO - Return code: 0 20:00:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:00:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:06 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 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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:06 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:00:06 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:00:06 INFO - Using env: {'DISPLAY': ':0', 20:00:06 INFO - 'HOME': '/home/cltbld', 20:00:06 INFO - 'LANG': 'en_US.UTF-8', 20:00:06 INFO - 'LANGUAGE': 'en_US:en', 20:00:06 INFO - 'LOGNAME': 'cltbld', 20:00:06 INFO - 'MAIL': '/var/mail/cltbld', 20:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:06 INFO - 'MOZ_NO_REMOTE': '1', 20:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:06 INFO - 'NO_EM_RESTART': '1', 20:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:06 INFO - 'SHELL': '/bin/bash', 20:00:06 INFO - 'SHLVL': '1', 20:00:06 INFO - 'TERM': 'linux', 20:00:06 INFO - 'TMOUT': '86400', 20:00:06 INFO - 'USER': 'cltbld', 20:00:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 20:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:06 INFO - '_': '/tools/buildbot/bin/python'} 20:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:06 INFO - Downloading/unpacking jsonschema 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:00:08 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:00:08 INFO - Downloading/unpacking functools32 (from jsonschema) 20:00: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:00: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:00: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:00: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:00: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:00: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:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 20:00:08 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:00:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:00:08 INFO - warning: no files found matching '*.txt' 20:00:08 INFO - no previously-included directories found matching 'build' 20:00:08 INFO - no previously-included directories found matching 'dist' 20:00:08 INFO - no previously-included directories found matching '.git*' 20:00:08 INFO - Installing collected packages: jsonschema, functools32 20:00:08 INFO - Running setup.py install for functools32 20:00:08 INFO - warning: no files found matching '*.txt' 20:00:08 INFO - no previously-included directories found matching 'build' 20:00:08 INFO - no previously-included directories found matching 'dist' 20:00:08 INFO - no previously-included directories found matching '.git*' 20:00:08 INFO - Successfully installed jsonschema functools32 20:00:08 INFO - Cleaning up... 20:00:08 INFO - Return code: 0 20:00:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f9bed4dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, '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': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', '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:08 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:00:08 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:00:08 INFO - Using env: {'DISPLAY': ':0', 20:00:08 INFO - 'HOME': '/home/cltbld', 20:00:08 INFO - 'LANG': 'en_US.UTF-8', 20:00:08 INFO - 'LANGUAGE': 'en_US:en', 20:00:08 INFO - 'LOGNAME': 'cltbld', 20:00:08 INFO - 'MAIL': '/var/mail/cltbld', 20:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:08 INFO - 'MOZ_NO_REMOTE': '1', 20:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:08 INFO - 'NO_EM_RESTART': '1', 20:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:08 INFO - 'SHELL': '/bin/bash', 20:00:08 INFO - 'SHLVL': '1', 20:00:08 INFO - 'TERM': 'linux', 20:00:08 INFO - 'TMOUT': '86400', 20:00:08 INFO - 'USER': 'cltbld', 20:00:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 20:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:08 INFO - '_': '/tools/buildbot/bin/python'} 20:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:09 INFO - Downloading/unpacking flake8 20:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:00:10 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:00:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:00:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:00:10 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:00:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:00:10 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:10 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:10 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:10 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:10 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:10 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:11 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:00:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:00: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:00: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:00: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:00: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:00: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:00: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:00:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:00:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:11 INFO - no previously-included directories found matching 'docs/_build' 20:00:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:00:11 INFO - Running setup.py install for pep8 20:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:11 INFO - no previously-included directories found matching 'docs/_build' 20:00:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:00:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:00:11 INFO - Cleaning up... 20:00:11 INFO - Return code: 0 20:00:11 INFO - Running post-action listener: _resource_record_post_action 20:00:11 INFO - Running post-action listener: _start_resource_monitoring 20:00:11 INFO - Starting resource monitoring. 20:00:11 INFO - ##### 20:00:11 INFO - ##### Running install step. 20:00:11 INFO - ##### 20:00:11 INFO - Running pre-action listener: _resource_record_pre_action 20:00:11 INFO - Running main action method: install 20:00:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:00:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:00:11 INFO - Reading from file tmpfile_stdout 20:00:11 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:00:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:00:12 INFO - Reading from file tmpfile_stdout 20:00:12 INFO - Output received: 20:00:12 INFO - Usage: mozinstall [options] installer 20:00:12 INFO - Options: 20:00:12 INFO - -h, --help show this help message and exit 20:00:12 INFO - -d DEST, --destination=DEST 20:00:12 INFO - Directory to install application into. [default: 20:00:12 INFO - "/builds/slave/test-pgo"] 20:00:12 INFO - --app=APP Application being installed. [default: firefox] 20:00:12 INFO - mkdir: /builds/slave/test-pgo/build/application 20:00:12 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:00:12 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:00:28 INFO - Reading from file tmpfile_stdout 20:00:28 INFO - Output received: 20:00:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:00:28 INFO - Running post-action listener: _resource_record_post_action 20:00:28 INFO - ##### 20:00:28 INFO - ##### Running run-tests step. 20:00:28 INFO - ##### 20:00:28 INFO - Running pre-action listener: _resource_record_pre_action 20:00:28 INFO - Running main action method: run_tests 20:00:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:00:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:00:28 INFO - Python 2.7.3 20:00:28 INFO - Return code: 0 20:00:28 INFO - grabbing minidump binary from tooltool 20:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:28 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 0x129b840>, '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 0x12086b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1208b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:00:28 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:00:28 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:00:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:28 INFO - Return code: 0 20:00:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:00:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:00:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:00:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:00:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:00:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:00:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:00:29 INFO - Return code: 0 20:00:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 20:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:00:29 INFO - Using env: {'DISPLAY': ':0', 20:00:29 INFO - 'HOME': '/home/cltbld', 20:00:29 INFO - 'LANG': 'en_US.UTF-8', 20:00:29 INFO - 'LANGUAGE': 'en_US:en', 20:00:29 INFO - 'LOGNAME': 'cltbld', 20:00:29 INFO - 'MAIL': '/var/mail/cltbld', 20:00:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:00:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:29 INFO - 'MOZ_NO_REMOTE': '1', 20:00:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:29 INFO - 'NO_EM_RESTART': '1', 20:00:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:00:29 INFO - 'SHELL': '/bin/bash', 20:00:29 INFO - 'SHLVL': '1', 20:00:29 INFO - 'TERM': 'linux', 20:00:29 INFO - 'TMOUT': '86400', 20:00:29 INFO - 'USER': 'cltbld', 20:00:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191', 20:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:29 INFO - '_': '/tools/buildbot/bin/python'} 20:00:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:00:29 INFO - mozversion application_buildid: 20160109173002 20:00:29 INFO - mozversion application_changeset: c06ff2c95163d8c4eabdf80643b08b93c1b16718 20:00:29 INFO - mozversion application_display_name: Nightly 20:00:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:29 INFO - mozversion application_name: Firefox 20:00:29 INFO - mozversion application_remotingname: firefox 20:00:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:00:29 INFO - mozversion application_vendor: Mozilla 20:00:29 INFO - mozversion application_version: 46.0a1 20:00:29 INFO - mozversion platform_buildid: 20160109173002 20:00:29 INFO - mozversion platform_changeset: c06ff2c95163d8c4eabdf80643b08b93c1b16718 20:00:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:00:29 INFO - mozversion platform_version: 46.0a1 20:00:29 INFO - using testdate: 1452398429 20:00:29 INFO - actual date: 1452398429 20:00:29 INFO - starting webserver on 'localhost:42808' 20:00:29 INFO - SUITE-START | Running 3 tests 20:00:29 INFO - TEST-START | dromaeo_css 20:00:29 INFO - operating with platform_type : linux_ 20:00:29 INFO - Initialising browser for dromaeo_css test... 20:00:29 INFO - TEST-INFO | started process 6880 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQvgoum/profile http://localhost:42808/getInfo.html) 20:00:33 INFO - PROCESS | 6880 | 20:00:33 INFO - PROCESS | 6880 | (process:6966): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:00:33 INFO - PROCESS | 6880 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:00:34 INFO - PROCESS | 6880 | __metrics Screen width/height:1600/1200 20:00:34 INFO - PROCESS | 6880 | colorDepth:24 20:00:34 INFO - PROCESS | 6880 | Browser inner width/height: 1024/697 20:00:34 INFO - PROCESS | 6880 | __metrics 20:00:34 INFO - PROCESS | 6880 | 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:00:34 INFO - TEST-INFO | 6880: exit 0 20:00:34 INFO - Browser initialized. 20:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 20:00:34 INFO - TEST-INFO | started process 7015 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQvgoum/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:36 INFO - PROCESS | 7015 | 20:00:36 INFO - PROCESS | 7015 | (process:7073): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:00:46 INFO - PROCESS | 7015 | RSS: Main: 150466560 20:00:46 INFO - PROCESS | 7015 | 20:01:36 INFO - PROCESS | 7015 | 1452398496434 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:03:45 INFO - PROCESS | 7015 | Cycle 1(1): loaded http://localhost:42808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42808/tests/dromaeo/cssquery-ext.html) 20:03:46 INFO - PROCESS | 7015 | RSS: Main: 159383552 20:03:46 INFO - PROCESS | 7015 | 20:06:48 INFO - PROCESS | 7015 | Cycle 1(1): loaded http://localhost:42808/tests/dromaeo/cssquery-ext.html (next: http://localhost:42808/tests/dromaeo/cssquery-jquery.html) 20:06:49 INFO - PROCESS | 7015 | RSS: Main: 153829376 20:06:49 INFO - PROCESS | 7015 | 20:09:50 INFO - PROCESS | 7015 | Cycle 1(1): loaded http://localhost:42808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42808/tests/dromaeo/cssquery-mootools.html) 20:09:51 INFO - PROCESS | 7015 | RSS: Main: 153612288 20:09:51 INFO - PROCESS | 7015 | 20:12:53 INFO - PROCESS | 7015 | Cycle 1(1): loaded http://localhost:42808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42808/tests/dromaeo/cssquery-prototype.html) 20:12:53 INFO - PROCESS | 7015 | RSS: Main: 151756800 20:12:53 INFO - PROCESS | 7015 | 20:15:56 INFO - PROCESS | 7015 | Cycle 1(1): loaded http://localhost:42808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42808/tests/dromaeo/cssquery-yui.html) 20:15:56 INFO - PROCESS | 7015 | RSS: Main: 153776128 20:15:56 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | Cycle 1(1): loaded http://localhost:42808/tests/dromaeo/cssquery-yui.html (next: http://localhost:42808/tests/dromaeo/cssquery-dojo.html) 20:18:59 INFO - PROCESS | 7015 | RSS: Main: 155611136 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | __start_tp_report 20:18:59 INFO - PROCESS | 7015 | _x_x_mozilla_page_load 20:18:59 INFO - PROCESS | 7015 | _x_x_mozilla_page_load_details 20:18:59 INFO - PROCESS | 7015 | |i|pagename|runs| 20:18:59 INFO - PROCESS | 7015 | |0;dojo.html;3174.7618928580355;3192.6966938140868;3220.4686226772583;3233.498807684808;3244.4160051190793;5149.74251287436;5197.844064678061;5211.42674305826;5215.452377500355;5225.137852254378;5177.32694749682;5230.476952304768;5248.448912864152;5376.569874410047;5397.973010134944;4855.295982082587;4880.438749543795;4919.508049195088;4949.208126699728;4975.378077740283;4782.97608511957;4838.927416088762;4843.78202980865;4872;4921.458639549664;4759.976200119012;4794.712317260941;4799.52004799519;4834.129856625806;4854.2233242681;4906.313116163704;4926.802927882881;4933.531314525115;4938.728369939652;4975.825846095369;4848.17581011229;4868.342773725537;4872.634552408584;4908.901821963541;4914.975425122887;5054.469280725508;5105.208692652608;5179.689218646893;5185.714785686786;5210.452902445227;5673.290838645169;5693.572982026323;5709.486146246816;5713.4000929902595;5720.370759216483;5593.664380137205;5689.345725241567;5736.68448235351;5740.397258287903;5746.224259724925;5193.896122077537;5195.9740201298755;5196.636235463519;5198.844034678966;5199.714015729133;5671.177679236487;5677.914831277534;5763.423657634287;5855.092460668603;5890.204822348928;5552.972235138879;5590.580706447033;5591.189277554732;5606.934682410329;5611.691356975405;5660.066089095336;5693.857653558694;5710.114932185518;5712.714364281769;5718;5541.833744987657;5618.073017952074;5639.379668236491;5709.9714501427225;5763.85590360236;5634.267545219095;5646.604737668324;5649.491545760901;5650.830475085754;5666.093425052054;4408.162449134654;4409.5149533551285;4415.492218394926;4425.955740442554;4453.131639330364;3886.7084968627464;3938.7045971552247;3997.740146890501;4024.557298697141;4037.7981100944835;5376.354837419534;5392.811251606175;5409.513143817076;5410.026195284808;5448.237246785453;5461.0716178249795;5742.684152371576;5791.420857914175;5793.073108302651;5795.88408231833;5187.299714538564;5223.608229382736;5280.735963201824;5293.841184764463;5338.652987555796;4769.451513075971;4795.232762757942;4808.663393562487;4837.782299796518;4839.806407743721;5810.622309549865;5831.271091113611;5832.387599302097;5847.239858818411;5885.028970219952;5541.085720856014;5541.944580554143;5552.500274975271;5561.721913904208;5567.220589117445;5705.3153621564015;5853.35613082552;5938.703064846827;5976.163337132892;5998.100284957117;5592.161175823659;5603.859903502282;5606.523445507178;5606.803761868315;5614.466625670555;5584.4136365681015;5673.687947162945;5689.715514224355;5690.800821971211;5704.942950570441;5445.782168713207;5571.498565129158;5602.467765562265;5641.153826925994;5697.202391665253;5592.5525957922455;5620.803271885465;5630.971845140748;5639.464250896158;5651.547876169979;5362.1420572708175;5473.042217611982;5512.889742205213;5538.196961440649;5564.666120032811;5484.725763711878;5575.776968921197;5600.57995650336;5604.607677462538;5656.43435656431;5452.0731475648445;5476.479734425223;5516.310461192351;5518.86202844916;5518.972405138109 20:18:59 INFO - PROCESS | 7015 | |1;ext.html;513.2788432252685;514.8790034341929;519.4960887938701;537.782198209725;549.9862503437411;35429.645703542956;36279;36305.0923726907;36316.09209769757;36352.272954540924;39250;39438;39506.209875802466;39560.208795824066;39868.202635947266;8398.580070996457;8613.784655383603;8628.741137765846;8632.352573556976;8640.524771137585;8346.916530834675;8519.40364174508;8525.531095789729;8533.232009119178;8536.146385361477;8711.433756805787;8815.338849586275;8820.470771753715;8826.161514656098;8830.646774129027;8554.48673079611;8612.09572994836;8667.566621668955;8694.39139260252;8709.695160669346;8412;8510.659573617047;8532.14678532148;8538.103499132563;8547.444416112932;40073.79963100195;40188.59811401878;40552.797236013925;40575.39136912949;40592.594074059176;3166.176794033568;3219.176041863201;3223;3235.385276797401;3306.35526072416;29260.56109158343;29486.85256573725;30400.54399184014;30432.239194020105;31043.68956310453;3960;3964.226722816627;3969.940450893239;3987.521497420299;4076.8980775480554;196272.99999999857;196288;196446;196623;197257;42462.15075698469;42972.14055718868;59635.70182149061;59978.400215998154;60124;40447.59552404438;40608.39087413691;40609.39085913714;40710.185796283906;40728;14454.349554270084;14510.201938893251;14596.12423254608;14624.707505849823;14649.121052736657;11766.235194712317;11825.226216067658;11889.881101188877;11905.761884762256;11927.403629818475;14452;14582.416703331748;14609.415623374945;14612.634684132769;14635.707285854223;5867.677277749679;5968.403159683997;5977.910331345033;5993.910091348634;6081.179040829431;969.2052516936045;984.6455276100598;988.4662282367441;1033.194108595297;1073.7208325835184;28693.713062869105;28746.856265718954;28816.567751483744;29149.27126821804;29149.27126821804;1021.477731192139;1033.4419413516766;1053.8840727519967;1093.9781204375868;1129.7345123896043;15143.80414839842;15235.847641523664;15275.61810954735;16418.343266269454;16888.240029198714;288906;290404;292763;292920;294108;51227.23159152616;52011.219831702554;52226;52295.47704522906;52320.476795232324;1359.16411406984;1364.5155969630837;1370.0888908875686;1392.102094149268;1402.7825687018324;28419.43161136807;30477.54283685791;30934.381312374077;31154;31613.683863161074;46853;47167.76416117897;47371.76314118407;47477.28784068311;47585.76207118942;285924;291005;291145;291577;291827;42081.78959105185;42391.3641295387;42761.786191068844;43219;43799;39021.6097839018;39637.20725585415;39843.80078099591;40233.396499053124;40466;36326.636733632324;36390.09024774402;36438;36733.44899826451;37196.25607487889;35958;36401.453978190875;36744.26511469809;36751.448728268566;36826.26347472982;38863.41704874373;39040.6095939037;39250;39851.60148398595;40216;28868.855655721585;28923.7107628921;29850;31034.68965310318;31202.687973119977;24822;27997.234890117274;28841.7115828839;29090;29375.85312073426 20:18:59 INFO - PROCESS | 7015 | |2;jquery.html;356.3727839003353;358.8923323003098;360.04049208858396;360.9115766637174;361.9131408461969;16255.431059912906;16354.754678679828;16634.168291585433;17188.96866188028;17380.044097574628;10975.670729878117;10979;15755.133467659274;15857.60355991098;15903.12532810695;4811.182099043162;5153.587712982952;5330.093884039703;5344.438833922441;5373.220882971967;5148.124818780816;5237.47625237477;5250.081235783741;5440.483154100354;5447.945520544803;5074.695518268897;5298.205269209611;5439.918401223985;5445.264889239961;5463.180522921554;5206.271122042898;5214.504622060898;5234.816781412632;5248.973755131238;5507.834764957058;5263.947360526384;5293.894122117536;5304.973475132639;5306.655067420644;5314.707691076989;11535.192536522447;15910.840891591051;18749.906250468797;19461.902690486597;19508.12213450398;1988.8508361872773;2022.2113375783456;2055.8149766520937;2075.4857440631313;2109.535902101535;9278.257739380833;9597.040295970417;9972.650957216463;10696.572137114506;12373.69065773354;1795.3985414886029;1822.362173239369;1846.3722334406232;1853.3328001919433;1859.33064096925;49316.26025609619;50616.24075638905;51885;55531.44468555303;56850.43149568493;9249.630014799333;9679.951600241953;9832.360896541844;9881.604735810632;9968.35205711641;12751.107422480338;12813.103082784115;12874.163179393498;12897.161684490478;12932.935335323264;7309.597972111585;7343.853122937511;7355.190928997806;7403.259674032662;7471.364933980563;7121.9643901780155;7173.318534739192;7184;7217.819554511179;7230.927690723131;3975.344068228768;4076.286649836267;4085.305498065336;4130.297849365615;4146.274401979642;1837.8939592089325;1841.4383612998165;1868.8136726880637;1922.9326973555858;1924.4419118455771;415.1323733397214;879.3273146043282;909.1226965977863;959.5538074795254;1018.8471729240673;10171.949140254252;10427.009434103747;10471.5272387095;10798.622048228275;10884.23810333285;447.8096808856223;464.1089108910899;466.2493385649102;473.9289106633964;476.8831636249141;4501.88745281364;5933.1396947443245;5987.850303742442;6033.698315084228;6058.515318774487;539196;543410;544311;549686;559862;37367.81316093402;44781.77609111933;53094.95597918192;69793.3020669797;71066.289337107;486.44302273896193;495.31646328067035;498.44423467833104;502.3946144895392;502.7787773379701;9723.56243969009;9920.454375009444;9963.750906227402;10024.298299118991;10105.9494702526;28703.712962870104;29879.850600746857;30620.234494137825;30658.693413066478;30864.691353086182;40267.19465610613;40367.79816100901;41087.38368924409;41570;41797.37303940504;7115.146182458138;7348.265173482609;7413.332800048021;7425;7454.6645400956;9139.954300228455;10544.314619549705;11086.501107450023;11321.603743869255;11375.772484550098;9138.771530711785;9367.344285900193;9720.513974301115;9758.365706229073;9840.671509346146;9354.95322523383;9539.23686105096;9737.464439455898;9929.702108936743;10246.6413675521;9189.448633082036;9304.860427093734;9672.371295866027;9692.515374231401;10102.14131798776;7346.96326518364;7526.473146879885;7535.585542795199;7644.80887977805;7656.464047516621;8799.736007919773;9190.586423611087;9194.724158275263;9277.16505514507;9429.57566909477 20:18:59 INFO - PROCESS | 7015 | |3;mootools.html;1385.092764239423;1402.7054318593096;1561.515930061681;1814.9291917768514;1840.20871025459;7710;7778.5721785301785;7891.60541972902;7902.72340468083;7957.801054973628;7934.2065793420625;7959.602019899011;7972.1629228931;8051;8054.476459030159;2336.0422226886935;2346.6480027995767;2349.0955981946986;2349.9177528786495;2364.798992085666;2393.8204634652384;2418.1415597462824;2422.39440139965;2426.9393265168424;2428.2715185444385;2332.486852892361;2357.7170739511284;2387.6537902004197;2390.4501964548163;2400.6399040143942;2346.4485845826216;2362.8936697848553;2382.0471811275456;2386.319898828834;2392.6052201386665;2408.494216214597;2408.662787209792;2425.7695518925852;2430.2344761400104;2438.305083051322;7955.681772729084;7990.12108668046;8046.275835174863;8078.27295543398;8100.189981001853;4871.853844384674;4941.382327209099;4962.62780291476;4986.526280003394;4990.675606085593;3231.4991176367466;3279.3769183854993;3293.061477478907;3342.715869151101;3345.414552453311;1031.3141760729106;1036.533559898049;1051.542578978147;1082.967510974672;1092.7213560542011;10885.891141088567;10977.12183025356;11019.173561982883;11045.061169800576;11076;4250.723702959298;4309.870703878889;4387.473503179639;4399.318105693623;4419.535948725402;8884;8896.377253592187;8898.59956301968;8902.955485222532;8908.242799361997;4786.545278198566;4793.760311984456;4798.664093513421;4811.230203167476;4830.66185367028;4372.934405983913;4395.7582332972;4404.207242696281;4428.33574963758;4438.889027774331;3414.334204830034;3474.91312717179;3488.0407887831047;3519.788812671197;3528.9294214115575;1090.8527348807968;1091.6233899304727;1097.7694684116266;1117.0505070689849;1168.6201984355118;1290.9289989050505;1296.2546535741985;1312.3044786263297;1318.5978276625528;1336.2917653643585;7269.672864720995;7271.527350722186;7426.405887528985;7449.14334851499;7467.551946883204;1130.1185075641013;1140.1278022312938;1148.8793676663997;1154.786364522566;1173.7065733566608;5581.553475721932;5722.341930678025;5769.509591684669;5795.275590551181;5820.679862607597;9079.18287354128;9272.907270927204;9408.106229908148;9446.952765236267;9477.336586439022;9123.270138388913;9206.158768246378;9232.492212928219;9273.768155796159;9371.250299975985;7490.400767938552;7547.660355284025;7584.355329797029;7676.80807979805;7711.0746710395115;7314;7321.670524826289;7341.229170936975;7371.668274927534;7426.628668566658;8074.878876816735;8214.671413143646;8280.668773249003;8340.541270229953;8511.616977236163;8327;8478.660853565789;8486.787830304293;8524.190201930807;8537.359698022548;6921.8961715575315;6983.1620205575655;7021.227664956953;7030.156381234285;7064.646767661699;7220.638968051681;7279.526830755984;7299.5620262784405;7315.926840731525;7425.7029718810645;6554.311797261219;6949.131358580177;7088.149422069178;7092.25531319204;7364.631768411451;6968.442524597918;6989.930100698928;7018.5788852669;7042.823929401806;7073.6463176839925;6818.181818181652;6819.318068193339;6836;6872.381485666314;6887.862242755217;6276.4351208389635;6290.559660823698;6326.810195694136;6404.551681382259;6406.167198264196;6395.872082558416;6440.774572890114;6461.289258181502;6468.6442245676935;6631.436327912182 20:18:59 INFO - PROCESS | 7015 | |4;prototype.html;332.46141251173094;338.71886334342497;343.178088478095;348.4511893767317;349.58050339592495;6165.8766824663535;6223.782167624134;6280.623162610246;6300.243970723508;6389.361063893608;6205.844853878655;6260.280067792205;6264.653099583588;6278.372162783719;6280.214973128359;4772.73749943753;4779.0441911617645;4786.856394308159;4792.592629626477;4795;4755.072760811643;4769.92676647755;4774.641901857357;4784.5693887550115;4809.567138957493;4661.044485880403;4673.135469938055;4687.92968105477;4700.670953033289;4704.97647511762;4669.719816810985;4670.509596492353;4683.110209060268;4688.64835137366;4704.929426058612;4025.19496100781;4026.5369482509595;4035.435039094529;4057.3102572562734;4065.4714887064492;5941.9601569725555;5943.465088142045;5944.256967879015;5952.226210592638;5956.583039187259;5308.601854860901;5455.5908306877145;5462.453754624506;5478.342598888119;5480.698561579112;6595.878700620858;6598.241202261754;6607.273199948002;6608.900866487006;6617.834554136137;4488.057507923308;4492.61812745917;4494.393256910308;4497.325401189815;4502.57225563571;6766.086578311914;6820.31796820319;6887.242403335629;6889.724411023603;6899.517033807636;4596.4254468191475;4598.747068911175;4604.930926036112;4611.700239484423;4614.192516309632;4675.7895894684825;4676.789544470507;4679.27471241958;4681.882952926204;4697.929531057037;5385.461453854661;5426.158945363475;5431.728413579305;5442.0204363215;5450.972745136249;6506.934930650727;6652.101966234593;6660.83347916306;6668.799936001928;6690.5316627836555;1624.2284914665677;1644.9342026319052;1671.156066186568;1675.346614820221;1678.3035040458074;1091.8744344400495;1092.9780655087518;1097.5884043483693;1100.301308669001;1105.1269497097364;6104.572679912363;6116.908246376308;6129.325774164839;6158.476529494954;6168.537359697951;6617.239017512951;6641.535092543476;6654.13496245485;6680.732770689216;6687.431568316651;6037.396260373927;6125.601835880742;6139.048447490646;6139.079138129227;6150.692465376803;3654.2691461707764;3656.067702735785;3656.0859785053735;3661.029827095822;3666.4866918631415;6992.93007069933;7022.859542809115;7033.085698859116;7045.084139061889;7051.153861536648;6705.7652982146365;6899.413549848319;6903.896441553381;6913.481488888253;6919.619420931796;6960.79117626472;6997.650117494105;7012.964935175291;7013.4038606719005;7017.403520700797;6684.665766711742;6697.732090716317;6724.764633238009;6729.158855143107;6733.764318248838;6506.41442270198;6535.967320163369;6575.901361479678;6635.8009259722285;6641.6422170130845;7026.156861176487;7028.262032486719;7046.2249152594195;7050.15398152225;7052.894206586802;4583.7249765012875;4623.722576645412;4633.606143477842;4638.698484598491;4641.837535686234;6705.161854768154;6749.9662501689145;6754.2570317266045;6775.186977562724;6994.860102797814;6706.228783689938;6707.228668703162;6746.392824645805;6773.356531129535;6774.966125169342;6627.801165965029;6649.268580456049;6680;6715.630640314829;6732.764353247613;6499.6425196612745;6556.2788093310655;6586.4401525870835;6589.769358072444;6593.175853018372;6648.767293144911;6699.933000670126;6704.966475167593;6707.5975441473665;6725.226598940989;6536.934630653633;6559.704813283509;6596.670166491752;6621.106150669598;6621.437177839937 20:18:59 INFO - PROCESS | 7015 | |5;yui.html;745.3143108340327;767.543311729521;807.7617102954628;840.9957950210252;867.618247970893;12206.511739530419;12511.999040076806;12516.81224781629;12548.184368016073;12568.497260109596;12091.214071085395;12128.69678258044;12132.090093242998;12134.575289864857;12167.391630418466;798.0383637716552;810.6109067647503;828.772087675888;831.1729828820332;833.3333333333339;814.722994181978;814.8411059843332;817.2113910076774;817.7710241132493;818.3657665309373;851.7955690634266;855.9400841941067;855.9743207703779;856.0027567883409;857.8155696525246;851.4891065360765;851.5316575883239;852.2968550945433;852.6631980367752;852.6631980367782;629.1569297141806;629.2291942370605;630.1713247080075;630.3696303696304;634.9238091429058;12905.741885162339;12938.741225175443;13043.413046412934;13105.934470327587;13117.540886069037;11629.825552616718;11706.122040846885;11746.530138794438;11784.646460606196;12047.096467764954;10063.949680251626;10071.5467803949;10307.639232626898;10680.25238233324;10928;3532.8233588320736;3621.6740493355724;3641.253543023674;3656.7988760618155;3729.1050147964565;42805.14389712188;42825;43027.569724302666;43078.13843723139;43445.782771086255;8754.124587541195;9122.589483473259;9235.399699019543;9315.813683726288;9450.385724927857;14987.625309367353;15445.996010259298;15511.146886921102;15512.689746205238;15518.456854010281;7361.779146625609;7392.519486233377;7519.812004699927;7586.924130758622;7753.573553454501;4360.672949528798;4416.80124394403;4424.889377765518;4460.442444694413;4464.15181115587;2914.184028472031;2919.357741296911;2922.4885645012037;2926.7365937065765;2933.3546619743624;539.5710410223803;550.2983695787823;567.234233784396;567.7416775367197;577.4946921443736;513.9434662187157;553.7646500237463;606.4814583531106;619.845038740315;651.5927545284197;7680.692772289046;7785.385049463907;7786.454948153688;7849.764507064797;7914.564698941614;555.8554775758332;594.6937327276456;674.436845234235;704.3449591879602;746.2798399544465;3766.3785475396253;3936.193080418507;3972.4835771350117;4004.379321205218;4011.959880401217;53786;53997.46002539925;54155.104571340606;54167.18749218765;57658.7117064412;48206.79483012883;48542.271865921335;48822.51177488251;48867.511324887004;49304.75347623239;45067.098658026654;45076;45101.97041133222;45592.772036139606;45593.316100258526;7682.961585192038;7981.64082616272;8055.436119471581;8079.792555283072;8179.222973817477;33023.174420639676;33202;33353.499697505045;33851.492227616116;34057.318853623285;38929;39388.409173861844;43190;43242.56757432385;43586;9510.429374237568;9581.520923953634;9603.807923841623;9718.465484398426;9826.754331141492;10684.83972740394;10745.194110441904;10807.405592692478;10870.184736144663;10977.835332470178;9980.401175929177;10293.53679084428;10522.78954420892;10579.15366770641;10624.521896514521;10298.742531436774;10518.158547316349;10522.210834187314;10547.789044219226;10554.841677374692;9632.95183524078;9949.095559474375;10066.748331291483;10145.442000690033;10285.74285642865;8589.914100858912;8736.001918024445;8790.296776257755;8956.417832840845;8982.236509896731;8108.79728006781;8130.349572034104;8199.524419607586;8445.535495547803;9571.760705982128 20:18:59 INFO - PROCESS | 7015 | __end_tp_report 20:18:59 INFO - PROCESS | 7015 | __start_cc_report 20:18:59 INFO - PROCESS | 7015 | _x_x_mozilla_cycle_collect,306 20:18:59 INFO - PROCESS | 7015 | __end_cc_report 20:18:59 INFO - PROCESS | 7015 | __startTimestamp1452399539544__endTimestamp 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | ------- Summary: start ------- 20:18:59 INFO - PROCESS | 7015 | Number of tests: 6 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | [#0] dojo.html Cycles:165 Average:5277.51 Median:5512.89 stddev:569.56 (10.3%) stddev-sans-first:546.90 20:18:59 INFO - PROCESS | 7015 | Values: 3174.8 3192.7 3220.5 3233.5 3244.4 5149.7 5197.8 5211.4 5215.5 5225.1 5177.3 5230.5 5248.4 5376.6 5398.0 4855.3 4880.4 4919.5 4949.2 4975.4 4783.0 4838.9 4843.8 4872.0 4921.5 4760.0 4794.7 4799.5 4834.1 4854.2 4906.3 4926.8 4933.5 4938.7 4975.8 4848.2 4868.3 4872.6 4908.9 4915.0 5054.5 5105.2 5179.7 5185.7 5210.5 5673.3 5693.6 5709.5 5713.4 5720.4 5593.7 5689.3 5736.7 5740.4 5746.2 5193.9 5196.0 5196.6 5198.8 5199.7 5671.2 5677.9 5763.4 5855.1 5890.2 5553.0 5590.6 5591.2 5606.9 5611.7 5660.1 5693.9 5710.1 5712.7 5718.0 5541.8 5618.1 5639.4 5710.0 5763.9 5634.3 5646.6 5649.5 5650.8 5666.1 4408.2 4409.5 4415.5 4426.0 4453.1 3886.7 3938.7 3997.7 4024.6 4037.8 5376.4 5392.8 5409.5 5410.0 5448.2 5461.1 5742.7 5791.4 5793.1 5795.9 5187.3 5223.6 5280.7 5293.8 5338.7 4769.5 4795.2 4808.7 4837.8 4839.8 5810.6 5831.3 5832.4 5847.2 5885.0 5541.1 5541.9 5552.5 5561.7 5567.2 5705.3 5853.4 5938.7 5976.2 5998.1 5592.2 5603.9 5606.5 5606.8 5614.5 5584.4 5673.7 5689.7 5690.8 5704.9 5445.8 5571.5 5602.5 5641.2 5697.2 5592.6 5620.8 5631.0 5639.5 5651.5 5362.1 5473.0 5512.9 5538.2 5564.7 5484.7 5575.8 5600.6 5604.6 5656.4 5452.1 5476.5 5516.3 5518.9 5519.0 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | [#1] ext.html Cycles:180 Average:42988.10 Median:37011.26 stddev:68667.17 (185.5%) stddev-sans-first:68785.74 20:18:59 INFO - PROCESS | 7015 | Values: 513.3 514.9 519.5 537.8 550.0 35429.6 36279.0 36305.1 36316.1 36352.3 39250.0 39438.0 39506.2 39560.2 39868.2 8398.6 8613.8 8628.7 8632.4 8640.5 8346.9 8519.4 8525.5 8533.2 8536.1 8711.4 8815.3 8820.5 8826.2 8830.6 8554.5 8612.1 8667.6 8694.4 8709.7 8412.0 8510.7 8532.1 8538.1 8547.4 40073.8 40188.6 40552.8 40575.4 40592.6 3166.2 3219.2 3223.0 3235.4 3306.4 29260.6 29486.9 30400.5 30432.2 31043.7 3960.0 3964.2 3969.9 3987.5 4076.9 196273.0 196288.0 196446.0 196623.0 197257.0 42462.2 42972.1 59635.7 59978.4 60124.0 40447.6 40608.4 40609.4 40710.2 40728.0 14454.3 14510.2 14596.1 14624.7 14649.1 11766.2 11825.2 11889.9 11905.8 11927.4 14452.0 14582.4 14609.4 14612.6 14635.7 5867.7 5968.4 5977.9 5993.9 6081.2 969.2 984.6 988.5 1033.2 1073.7 28693.7 28746.9 28816.6 29149.3 29149.3 1021.5 1033.4 1053.9 1094.0 1129.7 15143.8 15235.8 15275.6 16418.3 16888.2 288906.0 290404.0 292763.0 292920.0 294108.0 51227.2 52011.2 52226.0 52295.5 52320.5 1359.2 1364.5 1370.1 1392.1 1402.8 28419.4 30477.5 30934.4 31154.0 31613.7 46853.0 47167.8 47371.8 47477.3 47585.8 285924.0 291005.0 291145.0 291577.0 291827.0 42081.8 42391.4 42761.8 43219.0 43799.0 39021.6 39637.2 39843.8 40233.4 40466.0 36326.6 36390.1 36438.0 36733.4 37196.3 35958.0 36401.5 36744.3 36751.4 36826.3 38863.4 39040.6 39250.0 39851.6 40216.0 28868.9 28923.7 29850.0 31034.7 31202.7 24822.0 27997.2 28841.7 29090.0 29375.9 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | [#2] jquery.html Cycles:180 Average:26390.33 Median:28519.29 stddev:89284.07 (313.1%) stddev-sans-first:89513.13 20:18:59 INFO - PROCESS | 7015 | Values: 356.4 358.9 360.0 360.9 361.9 16255.4 16354.8 16634.2 17189.0 17380.0 10975.7 10979.0 15755.1 15857.6 15903.1 4811.2 5153.6 5330.1 5344.4 5373.2 5148.1 5237.5 5250.1 5440.5 5447.9 5074.7 5298.2 5439.9 5445.3 5463.2 5206.3 5214.5 5234.8 5249.0 5507.8 5263.9 5293.9 5305.0 5306.7 5314.7 11535.2 15910.8 18749.9 19461.9 19508.1 1988.9 2022.2 2055.8 2075.5 2109.5 9278.3 9597.0 9972.7 10696.6 12373.7 1795.4 1822.4 1846.4 1853.3 1859.3 49316.3 50616.2 51885.0 55531.4 56850.4 9249.6 9680.0 9832.4 9881.6 9968.4 12751.1 12813.1 12874.2 12897.2 12932.9 7309.6 7343.9 7355.2 7403.3 7471.4 7122.0 7173.3 7184.0 7217.8 7230.9 3975.3 4076.3 4085.3 4130.3 4146.3 1837.9 1841.4 1868.8 1922.9 1924.4 415.1 879.3 909.1 959.6 1018.8 10171.9 10427.0 10471.5 10798.6 10884.2 447.8 464.1 466.2 473.9 476.9 4501.9 5933.1 5987.9 6033.7 6058.5 539196.0 543410.0 544311.0 549686.0 559862.0 37367.8 44781.8 53095.0 69793.3 71066.3 486.4 495.3 498.4 502.4 502.8 9723.6 9920.5 9963.8 10024.3 10105.9 28703.7 29879.9 30620.2 30658.7 30864.7 40267.2 40367.8 41087.4 41570.0 41797.4 7115.1 7348.3 7413.3 7425.0 7454.7 9140.0 10544.3 11086.5 11321.6 11375.8 9138.8 9367.3 9720.5 9758.4 9840.7 9355.0 9539.2 9737.5 9929.7 10246.6 9189.4 9304.9 9672.4 9692.5 10102.1 7347.0 7526.5 7535.6 7644.8 7656.5 8799.7 9190.6 9194.7 9277.2 9429.6 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | [#3] mootools.html Cycles:180 Average:5518.32 Median:6283.50 stddev:2805.66 (44.7%) stddev-sans-first:2796.33 20:18:59 INFO - PROCESS | 7015 | Values: 1385.1 1402.7 1561.5 1814.9 1840.2 7710.0 7778.6 7891.6 7902.7 7957.8 7934.2 7959.6 7972.2 8051.0 8054.5 2336.0 2346.6 2349.1 2349.9 2364.8 2393.8 2418.1 2422.4 2426.9 2428.3 2332.5 2357.7 2387.7 2390.5 2400.6 2346.4 2362.9 2382.0 2386.3 2392.6 2408.5 2408.7 2425.8 2430.2 2438.3 7955.7 7990.1 8046.3 8078.3 8100.2 4871.9 4941.4 4962.6 4986.5 4990.7 3231.5 3279.4 3293.1 3342.7 3345.4 1031.3 1036.5 1051.5 1083.0 1092.7 10885.9 10977.1 11019.2 11045.1 11076.0 4250.7 4309.9 4387.5 4399.3 4419.5 8884.0 8896.4 8898.6 8903.0 8908.2 4786.5 4793.8 4798.7 4811.2 4830.7 4372.9 4395.8 4404.2 4428.3 4438.9 3414.3 3474.9 3488.0 3519.8 3528.9 1090.9 1091.6 1097.8 1117.1 1168.6 1290.9 1296.3 1312.3 1318.6 1336.3 7269.7 7271.5 7426.4 7449.1 7467.6 1130.1 1140.1 1148.9 1154.8 1173.7 5581.6 5722.3 5769.5 5795.3 5820.7 9079.2 9272.9 9408.1 9447.0 9477.3 9123.3 9206.2 9232.5 9273.8 9371.3 7490.4 7547.7 7584.4 7676.8 7711.1 7314.0 7321.7 7341.2 7371.7 7426.6 8074.9 8214.7 8280.7 8340.5 8511.6 8327.0 8478.7 8486.8 8524.2 8537.4 6921.9 6983.2 7021.2 7030.2 7064.6 7220.6 7279.5 7299.6 7315.9 7425.7 6554.3 6949.1 7088.1 7092.3 7364.6 6968.4 6989.9 7018.6 7042.8 7073.6 6818.2 6819.3 6836.0 6872.4 6887.9 6276.4 6290.6 6326.8 6404.6 6406.2 6395.9 6440.8 6461.3 6468.6 6631.4 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | [#4] prototype.html Cycles:180 Average:5494.04 Median:6187.19 stddev:1667.91 (27.0%) stddev-sans-first:1626.98 20:18:59 INFO - PROCESS | 7015 | Values: 332.5 338.7 343.2 348.5 349.6 6165.9 6223.8 6280.6 6300.2 6389.4 6205.8 6260.3 6264.7 6278.4 6280.2 4772.7 4779.0 4786.9 4792.6 4795.0 4755.1 4769.9 4774.6 4784.6 4809.6 4661.0 4673.1 4687.9 4700.7 4705.0 4669.7 4670.5 4683.1 4688.6 4704.9 4025.2 4026.5 4035.4 4057.3 4065.5 5942.0 5943.5 5944.3 5952.2 5956.6 5308.6 5455.6 5462.5 5478.3 5480.7 6595.9 6598.2 6607.3 6608.9 6617.8 4488.1 4492.6 4494.4 4497.3 4502.6 6766.1 6820.3 6887.2 6889.7 6899.5 4596.4 4598.7 4604.9 4611.7 4614.2 4675.8 4676.8 4679.3 4681.9 4697.9 5385.5 5426.2 5431.7 5442.0 5451.0 6506.9 6652.1 6660.8 6668.8 6690.5 1624.2 1644.9 1671.2 1675.3 1678.3 1091.9 1093.0 1097.6 1100.3 1105.1 6104.6 6116.9 6129.3 6158.5 6168.5 6617.2 6641.5 6654.1 6680.7 6687.4 6037.4 6125.6 6139.0 6139.1 6150.7 3654.3 3656.1 3656.1 3661.0 3666.5 6992.9 7022.9 7033.1 7045.1 7051.2 6705.8 6899.4 6903.9 6913.5 6919.6 6960.8 6997.7 7013.0 7013.4 7017.4 6684.7 6697.7 6724.8 6729.2 6733.8 6506.4 6536.0 6575.9 6635.8 6641.6 7026.2 7028.3 7046.2 7050.2 7052.9 4583.7 4623.7 4633.6 4638.7 4641.8 6705.2 6750.0 6754.3 6775.2 6994.9 6706.2 6707.2 6746.4 6773.4 6775.0 6627.8 6649.3 6680.0 6715.6 6732.8 6499.6 6556.3 6586.4 6589.8 6593.2 6648.8 6699.9 6705.0 6707.6 6725.2 6536.9 6559.7 6596.7 6621.1 6621.4 20:18:59 INFO - PROCESS | 7015 | 20:18:59 INFO - PROCESS | 7015 | [#5] yui.html Cycles:180 Average:12913.32 Median:49086.13 stddev:15043.85 (30.6%) stddev-sans-first:15058.30 20:18:59 INFO - PROCESS | 7015 | Values: 745.3 767.5 807.8 841.0 867.6 12206.5 12512.0 12516.8 12548.2 12568.5 12091.2 12128.7 12132.1 12134.6 12167.4 798.0 810.6 828.8 831.2 833.3 814.7 814.8 817.2 817.8 818.4 851.8 855.9 856.0 856.0 857.8 851.5 851.5 852.3 852.7 852.7 629.2 629.2 630.2 630.4 634.9 12905.7 12938.7 13043.4 13105.9 13117.5 11629.8 11706.1 11746.5 11784.6 12047.1 10063.9 10071.5 10307.6 10680.3 10928.0 3532.8 3621.7 3641.3 3656.8 3729.1 42805.1 42825.0 43027.6 43078.1 43445.8 8754.1 9122.6 9235.4 9315.8 9450.4 14987.6 15446.0 15511.1 15512.7 15518.5 7361.8 7392.5 7519.8 7586.9 7753.6 4360.7 4416.8 4424.9 4460.4 4464.2 2914.2 2919.4 2922.5 2926.7 2933.4 539.6 550.3 567.2 567.7 577.5 513.9 553.8 606.5 619.8 651.6 7680.7 7785.4 7786.5 7849.8 7914.6 555.9 594.7 674.4 704.3 746.3 3766.4 3936.2 3972.5 4004.4 4012.0 53786.0 53997.5 54155.1 54167.2 57658.7 48206.8 48542.3 48822.5 48867.5 49304.8 45067.1 45076.0 45102.0 45592.8 45593.3 7683.0 7981.6 8055.4 8079.8 8179.2 33023.2 33202.0 33353.5 33851.5 34057.3 38929.0 39388.4 43190.0 43242.6 43586.0 9510.4 9581.5 9603.8 9718.5 9826.8 10684.8 10745.2 10807.4 10870.2 10977.8 9980.4 10293.5 10522.8 10579.2 10624.5 10298.7 10518.2 10522.2 10547.8 10554.8 9633.0 9949.1 10066.7 10145.4 10285.7 8589.9 8736.0 8790.3 8956.4 8982.2 8108.8 8130.3 8199.5 8445.5 9571.8 20:18:59 INFO - PROCESS | 7015 | -------- Summary: end -------- 20:18:59 INFO - PROCESS | 7015 | 20:19:00 INFO - TEST-INFO | 7015: exit 0 20:19:00 INFO - TEST-OK | dromaeo_css | took 1110783ms 20:19:00 INFO - TEST-START | kraken 20:19:00 INFO - operating with platform_type : linux_ 20:19:00 INFO - Initialising browser for kraken test... 20:19:00 INFO - TEST-INFO | started process 7259 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMuQkq1/profile http://localhost:42808/getInfo.html) 20:19:03 INFO - PROCESS | 7259 | 20:19:03 INFO - PROCESS | 7259 | (process:7330): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:19:03 INFO - PROCESS | 7259 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:19:04 INFO - PROCESS | 7259 | __metrics Screen width/height:1600/1200 20:19:04 INFO - PROCESS | 7259 | colorDepth:24 20:19:04 INFO - PROCESS | 7259 | Browser inner width/height: 1024/697 20:19:04 INFO - PROCESS | 7259 | __metrics 20:19:04 INFO - PROCESS | 7259 | 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:19:05 INFO - TEST-INFO | 7259: exit 0 20:19:05 INFO - Browser initialized. 20:19:05 INFO - Running cycle 1/1 for kraken test... 20:19:05 INFO - TEST-INFO | started process 7379 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMuQkq1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:06 INFO - PROCESS | 7379 | 20:19:06 INFO - PROCESS | 7379 | (process:7440): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:19:17 INFO - PROCESS | 7379 | RSS: Main: 150446080 20:19:17 INFO - PROCESS | 7379 | 20:19:19 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42808/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:20 INFO - PROCESS | 7379 | RSS: Main: 151203840 20:19:20 INFO - PROCESS | 7379 | 20:19:23 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42808/tests/kraken/driver.html?testName=audio-dft) 20:19:23 INFO - PROCESS | 7379 | RSS: Main: 150282240 20:19:23 INFO - PROCESS | 7379 | 20:19:26 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42808/tests/kraken/driver.html?testName=audio-fft) 20:19:27 INFO - PROCESS | 7379 | RSS: Main: 146800640 20:19:27 INFO - PROCESS | 7379 | 20:19:29 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42808/tests/kraken/driver.html?testName=audio-oscillator) 20:19:29 INFO - PROCESS | 7379 | RSS: Main: 146649088 20:19:29 INFO - PROCESS | 7379 | 20:19:32 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:32 INFO - PROCESS | 7379 | RSS: Main: 147443712 20:19:32 INFO - PROCESS | 7379 | 20:19:35 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42808/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:36 INFO - PROCESS | 7379 | RSS: Main: 147181568 20:19:36 INFO - PROCESS | 7379 | 20:19:39 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42808/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:40 INFO - PROCESS | 7379 | RSS: Main: 148791296 20:19:40 INFO - PROCESS | 7379 | 20:19:43 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42808/tests/kraken/driver.html?testName=json-parse-financial) 20:19:43 INFO - PROCESS | 7379 | RSS: Main: 148942848 20:19:43 INFO - PROCESS | 7379 | 20:19:45 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:45 INFO - PROCESS | 7379 | RSS: Main: 148750336 20:19:45 INFO - PROCESS | 7379 | 20:19:47 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:48 INFO - PROCESS | 7379 | RSS: Main: 148963328 20:19:48 INFO - PROCESS | 7379 | 20:19:50 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:50 INFO - PROCESS | 7379 | RSS: Main: 149299200 20:19:50 INFO - PROCESS | 7379 | 20:19:53 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:53 INFO - PROCESS | 7379 | RSS: Main: 149639168 20:19:53 INFO - PROCESS | 7379 | 20:19:56 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:57 INFO - PROCESS | 7379 | RSS: Main: 148492288 20:19:57 INFO - PROCESS | 7379 | 20:19:58 INFO - PROCESS | 7379 | Cycle 1(1): loaded http://localhost:42808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42808/tests/kraken/driver.html?testName=ai-astar) 20:19:59 INFO - PROCESS | 7379 | RSS: Main: 148631552 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | __start_tp_report 20:19:59 INFO - PROCESS | 7379 | _x_x_mozilla_page_load 20:19:59 INFO - PROCESS | 7379 | _x_x_mozilla_page_load_details 20:19:59 INFO - PROCESS | 7379 | |i|pagename|runs| 20:19:59 INFO - PROCESS | 7379 | |0;ai-astar;111;106;112;110;112;122;112;111;111;111 20:19:59 INFO - PROCESS | 7379 | |1;audio-beat-detection;152;127;152;163;125;149;154;128;170;126 20:19:59 INFO - PROCESS | 7379 | |2;audio-dft;163;164;163;164;162;164;162;163;172;164 20:19:59 INFO - PROCESS | 7379 | |3;audio-fft;73;73;76;72;71;71;146;73;71;71 20:19:59 INFO - PROCESS | 7379 | |4;audio-oscillator;96;97;149;95;96;95;136;96;95;144 20:19:59 INFO - PROCESS | 7379 | |5;imaging-gaussian-blur;110;111;110;110;110;110;109;110;110;110 20:19:59 INFO - PROCESS | 7379 | |6;imaging-darkroom;147;148;147;147;148;149;148;148;147;148 20:19:59 INFO - PROCESS | 7379 | |7;imaging-desaturate;99;97;97;97;97;97;98;97;96;97 20:19:59 INFO - PROCESS | 7379 | |8;json-parse-financial;61;56;58;55;59;58;55;56;54;55 20:19:59 INFO - PROCESS | 7379 | |9;json-stringify-tinderbox;67;67;66;67;68;68;66;67;68;67 20:19:59 INFO - PROCESS | 7379 | |10;stanford-crypto-aes;85;87;94;86;86;85;87;87;88;87 20:19:59 INFO - PROCESS | 7379 | |11;stanford-crypto-ccm;119;126;126;120;122;127;120;121;125;126 20:19:59 INFO - PROCESS | 7379 | |12;stanford-crypto-pbkdf2;144;158;156;153;156;143;155;155;155;156 20:19:59 INFO - PROCESS | 7379 | |13;stanford-crypto-sha256-iterative;69;70;67;69;70;67;74;69;68;67 20:19:59 INFO - PROCESS | 7379 | __end_tp_report 20:19:59 INFO - PROCESS | 7379 | __start_cc_report 20:19:59 INFO - PROCESS | 7379 | _x_x_mozilla_cycle_collect,731 20:19:59 INFO - PROCESS | 7379 | __end_cc_report 20:19:59 INFO - PROCESS | 7379 | __startTimestamp1452399599146__endTimestamp 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | ------- Summary: start ------- 20:19:59 INFO - PROCESS | 7379 | Number of tests: 14 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:3.99 (3.6%) stddev-sans-first:4.23 20:19:59 INFO - PROCESS | 7379 | Values: 111.0 106.0 112.0 110.0 112.0 122.0 112.0 111.0 111.0 111.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:152.00 stddev:16.72 (11.0%) stddev-sans-first:17.52 20:19:59 INFO - PROCESS | 7379 | Values: 152.0 127.0 152.0 163.0 125.0 149.0 154.0 128.0 170.0 126.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:3.03 20:19:59 INFO - PROCESS | 7379 | Values: 163.0 164.0 163.0 164.0 162.0 164.0 162.0 163.0 172.0 164.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#3] audio-fft Cycles:10 Average:79.70 Median:72.50 stddev:23.35 (32.2%) stddev-sans-first:24.64 20:19:59 INFO - PROCESS | 7379 | Values: 73.0 73.0 76.0 72.0 71.0 71.0 146.0 73.0 71.0 71.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.50 stddev:23.06 (24.1%) stddev-sans-first:23.90 20:19:59 INFO - PROCESS | 7379 | Values: 96.0 97.0 149.0 95.0 96.0 95.0 136.0 96.0 95.0 144.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:19:59 INFO - PROCESS | 7379 | Values: 110.0 111.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 20:19:59 INFO - PROCESS | 7379 | Values: 147.0 148.0 147.0 147.0 148.0 149.0 148.0 148.0 147.0 148.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 20:19:59 INFO - PROCESS | 7379 | Values: 99.0 97.0 97.0 97.0 97.0 97.0 98.0 97.0 96.0 97.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:2.21 (3.9%) stddev-sans-first:1.72 20:19:59 INFO - PROCESS | 7379 | Values: 61.0 56.0 58.0 55.0 59.0 58.0 55.0 56.0 54.0 55.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 20:19:59 INFO - PROCESS | 7379 | Values: 67.0 67.0 66.0 67.0 68.0 68.0 66.0 67.0 68.0 67.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:2.57 (3.0%) stddev-sans-first:2.60 20:19:59 INFO - PROCESS | 7379 | Values: 85.0 87.0 94.0 86.0 86.0 85.0 87.0 87.0 88.0 87.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:125.50 stddev:3.08 (2.5%) stddev-sans-first:2.87 20:19:59 INFO - PROCESS | 7379 | Values: 119.0 126.0 126.0 120.0 122.0 127.0 120.0 121.0 125.0 126.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:155.50 stddev:5.22 (3.4%) stddev-sans-first:4.37 20:19:59 INFO - PROCESS | 7379 | Values: 144.0 158.0 156.0 153.0 156.0 143.0 155.0 155.0 155.0 156.0 20:19:59 INFO - PROCESS | 7379 | 20:19:59 INFO - PROCESS | 7379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.11 (3.1%) stddev-sans-first:2.24 20:19:59 INFO - PROCESS | 7379 | Values: 69.0 70.0 67.0 69.0 70.0 67.0 74.0 69.0 68.0 67.0 20:19:59 INFO - PROCESS | 7379 | -------- Summary: end -------- 20:19:59 INFO - PROCESS | 7379 | 20:20:00 INFO - TEST-INFO | 7379: exit 0 20:20:00 INFO - TEST-OK | kraken | took 59982ms 20:20:00 INFO - TEST-START | v8_7 20:20:00 INFO - operating with platform_type : linux_ 20:20:00 INFO - Initialising browser for v8_7 test... 20:20:00 INFO - TEST-INFO | started process 7668 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfy1RzN/profile http://localhost:42808/getInfo.html) 20:20:03 INFO - PROCESS | 7668 | 20:20:03 INFO - PROCESS | 7668 | (process:7743): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:20:03 INFO - PROCESS | 7668 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:20:04 INFO - PROCESS | 7668 | __metrics Screen width/height:1600/1200 20:20:04 INFO - PROCESS | 7668 | colorDepth:24 20:20:04 INFO - PROCESS | 7668 | Browser inner width/height: 1024/697 20:20:04 INFO - PROCESS | 7668 | __metrics 20:20:04 INFO - PROCESS | 7668 | 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:05 INFO - TEST-INFO | 7668: exit 0 20:20:05 INFO - Browser initialized. 20:20:05 INFO - Running cycle 1/1 for v8_7 test... 20:20:05 INFO - TEST-INFO | started process 7792 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfy1RzN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:06 INFO - PROCESS | 7792 | 20:20:06 INFO - PROCESS | 7792 | (process:7850): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:20:17 INFO - PROCESS | 7792 | RSS: Main: 150716416 20:20:17 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | Cycle 1(1): loaded http://localhost:42808/tests/v8_7/run.html (next: http://localhost:42808/tests/v8_7/run.html) 20:20:39 INFO - PROCESS | 7792 | RSS: Main: 146935808 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | __start_tp_report 20:20:39 INFO - PROCESS | 7792 | _x_x_mozilla_page_load 20:20:39 INFO - PROCESS | 7792 | _x_x_mozilla_page_load_details 20:20:39 INFO - PROCESS | 7792 | |i|pagename|runs| 20:20:39 INFO - PROCESS | 7792 | |0;Richards;170.44486108743823 20:20:39 INFO - PROCESS | 7792 | |1;DeltaBlue;197.04433497536945 20:20:39 INFO - PROCESS | 7792 | |2;Encrypt;283.68794326241135 20:20:39 INFO - PROCESS | 7792 | |3;Decrypt;5235.602094240838 20:20:39 INFO - PROCESS | 7792 | |4;RayTrace;1076.4262648008612 20:20:39 INFO - PROCESS | 7792 | |5;Earley;709.2198581560284 20:20:39 INFO - PROCESS | 7792 | |6;Boyer;12243.90243902439 20:20:39 INFO - PROCESS | 7792 | |7;RegExp;42354.166666666664 20:20:39 INFO - PROCESS | 7792 | |8;Splay;575.3739930955121 20:20:39 INFO - PROCESS | 7792 | |9;NavierStokes;4845.410628019324 20:20:39 INFO - PROCESS | 7792 | __end_tp_report 20:20:39 INFO - PROCESS | 7792 | __startTimestamp1452399639909__endTimestamp 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | ------- Summary: start ------- 20:20:39 INFO - PROCESS | 7792 | Number of tests: 10 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#0] Richards Cycles:1 Average:170.44 Median:170.44 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 170.4 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#1] DeltaBlue Cycles:1 Average:197.04 Median:197.04 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 197.0 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#2] Encrypt Cycles:1 Average:283.69 Median:283.69 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 283.7 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 5235.6 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 1076.4 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 709.2 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 12243.9 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#7] RegExp Cycles:1 Average:42354.17 Median:42354.17 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 42354.2 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#8] Splay Cycles:1 Average:575.37 Median:575.37 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 575.4 20:20:39 INFO - PROCESS | 7792 | 20:20:39 INFO - PROCESS | 7792 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 20:20:39 INFO - PROCESS | 7792 | Values: 4845.4 20:20:39 INFO - PROCESS | 7792 | -------- Summary: end -------- 20:20:39 INFO - PROCESS | 7792 | 20:20:40 INFO - TEST-INFO | 7792: exit 0 20:20:40 INFO - TEST-OK | v8_7 | took 40580ms 20:20:40 INFO - SUITE-END | took 1211s 20:20:40 INFO - Completed test suite (00:20:11) 20:20:40 INFO - Working with test: dromaeo_css 20:20:40 INFO - Generating results file: dromaeo_css 20:20:40 INFO - Working with test: kraken 20:20:40 INFO - Generating results file: kraken 20:20:40 INFO - javascript benchmark 20:20:40 INFO - Working with test: v8_7 20:20:40 INFO - Generating results file: v8_7 20:20:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:20:41 INFO - process_Request line: dromaeo_css 6730.00 graph.html#tests=[[72,64,43]] 20:20:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:41 INFO - process_Request line: kraken 1521.30 graph.html#tests=[[232,64,43]] 20:20:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:41 INFO - process_Request line: v8_7 20232.94 graph.html#tests=[[230,64,43]] 20:20:41 INFO - RETURN: dromaeo_css: 6730.00 20:20:41 INFO - RETURN: kraken: 1521.30 20:20:41 INFO - RETURN: v8_7: 20232.94 20:20:41 INFO - javascript benchmark 20:20:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3174.7618928580355, 3192.6966938140868, 3220.4686226772583, 3233.498807684808, 3244.4160051190793, 5149.74251287436, 5197.844064678061, 5211.42674305826, 5215.452377500355, 5225.137852254378, 5177.32694749682, 5230.476952304768, 5248.448912864152, 5376.569874410047, 5397.973010134944, 4855.295982082587, 4880.438749543795, 4919.508049195088, 4949.208126699728, 4975.378077740283, 4782.97608511957, 4838.927416088762, 4843.78202980865, 4872.0, 4921.458639549664, 4759.976200119012, 4794.712317260941, 4799.52004799519, 4834.129856625806, 4854.2233242681, 4906.313116163704, 4926.802927882881, 4933.531314525115, 4938.728369939652, 4975.825846095369, 4848.17581011229, 4868.342773725537, 4872.634552408584, 4908.901821963541, 4914.975425122887, 5054.469280725508, 5105.208692652608, 5179.689218646893, 5185.714785686786, 5210.452902445227, 5673.290838645169, 5693.572982026323, 5709.486146246816, 5713.4000929902595, 5720.370759216483, 5593.664380137205, 5689.345725241567, 5736.68448235351, 5740.397258287903, 5746.224259724925, 5193.896122077537, 5195.9740201298755, 5196.636235463519, 5198.844034678966, 5199.714015729133, 5671.177679236487, 5677.914831277534, 5763.423657634287, 5855.092460668603, 5890.204822348928, 5552.972235138879, 5590.580706447033, 5591.189277554732, 5606.934682410329, 5611.691356975405, 5660.066089095336, 5693.857653558694, 5710.114932185518, 5712.714364281769, 5718.0, 5541.833744987657, 5618.073017952074, 5639.379668236491, 5709.9714501427225, 5763.85590360236, 5634.267545219095, 5646.604737668324, 5649.491545760901, 5650.830475085754, 5666.093425052054, 4408.162449134654, 4409.5149533551285, 4415.492218394926, 4425.955740442554, 4453.131639330364, 3886.7084968627464, 3938.7045971552247, 3997.740146890501, 4024.557298697141, 4037.7981100944835, 5376.354837419534, 5392.811251606175, 5409.513143817076, 5410.026195284808, 5448.237246785453, 5461.0716178249795, 5742.684152371576, 5791.420857914175, 5793.073108302651, 5795.88408231833, 5187.299714538564, 5223.608229382736, 5280.735963201824, 5293.841184764463, 5338.652987555796, 4769.451513075971, 4795.232762757942, 4808.663393562487, 4837.782299796518, 4839.806407743721, 5810.622309549865, 5831.271091113611, 5832.387599302097, 5847.239858818411, 5885.028970219952, 5541.085720856014, 5541.944580554143, 5552.500274975271, 5561.721913904208, 5567.220589117445, 5705.3153621564015, 5853.35613082552, 5938.703064846827, 5976.163337132892, 5998.100284957117, 5592.161175823659, 5603.859903502282, 5606.523445507178, 5606.803761868315, 5614.466625670555, 5584.4136365681015, 5673.687947162945, 5689.715514224355, 5690.800821971211, 5704.942950570441, 5445.782168713207, 5571.498565129158, 5602.467765562265, 5641.153826925994, 5697.202391665253, 5592.5525957922455, 5620.803271885465, 5630.971845140748, 5639.464250896158, 5651.547876169979, 5362.1420572708175, 5473.042217611982, 5512.889742205213, 5538.196961440649, 5564.666120032811, 5484.725763711878, 5575.776968921197, 5600.57995650336, 5604.607677462538, 5656.43435656431, 5452.0731475648445, 5476.479734425223, 5516.310461192351, 5518.86202844916, 5518.972405138109], "unit": "score", "name": "dojo.html", "value": 5241.796399689307}, {"lowerIsBetter": false, "replicates": [513.2788432252685, 514.8790034341929, 519.4960887938701, 537.782198209725, 549.9862503437411, 35429.645703542956, 36279.0, 36305.0923726907, 36316.09209769757, 36352.272954540924, 39250.0, 39438.0, 39506.209875802466, 39560.208795824066, 39868.202635947266, 8398.580070996457, 8613.784655383603, 8628.741137765846, 8632.352573556976, 8640.524771137585, 8346.916530834675, 8519.40364174508, 8525.531095789729, 8533.232009119178, 8536.146385361477, 8711.433756805787, 8815.338849586275, 8820.470771753715, 8826.161514656098, 8830.646774129027, 8554.48673079611, 8612.09572994836, 8667.566621668955, 8694.39139260252, 8709.695160669346, 8412.0, 8510.659573617047, 8532.14678532148, 8538.103499132563, 8547.444416112932, 40073.79963100195, 40188.59811401878, 40552.797236013925, 40575.39136912949, 40592.594074059176, 3166.176794033568, 3219.176041863201, 3223.0, 3235.385276797401, 3306.35526072416, 29260.56109158343, 29486.85256573725, 30400.54399184014, 30432.239194020105, 31043.68956310453, 3960.0, 3964.226722816627, 3969.940450893239, 3987.521497420299, 4076.8980775480554, 196272.99999999857, 196288.0, 196446.0, 196623.0, 197257.0, 42462.15075698469, 42972.14055718868, 59635.70182149061, 59978.400215998154, 60124.0, 40447.59552404438, 40608.39087413691, 40609.39085913714, 40710.185796283906, 40728.0, 14454.349554270084, 14510.201938893251, 14596.12423254608, 14624.707505849823, 14649.121052736657, 11766.235194712317, 11825.226216067658, 11889.881101188877, 11905.761884762256, 11927.403629818475, 14452.0, 14582.416703331748, 14609.415623374945, 14612.634684132769, 14635.707285854223, 5867.677277749679, 5968.403159683997, 5977.910331345033, 5993.910091348634, 6081.179040829431, 969.2052516936045, 984.6455276100598, 988.4662282367441, 1033.194108595297, 1073.7208325835184, 28693.713062869105, 28746.856265718954, 28816.567751483744, 29149.27126821804, 29149.27126821804, 1021.477731192139, 1033.4419413516766, 1053.8840727519967, 1093.9781204375868, 1129.7345123896043, 15143.80414839842, 15235.847641523664, 15275.61810954735, 16418.343266269454, 16888.240029198714, 288906.0, 290404.0, 292763.0, 292920.0, 294108.0, 51227.23159152616, 52011.219831702554, 52226.0, 52295.47704522906, 52320.476795232324, 1359.16411406984, 1364.5155969630837, 1370.0888908875686, 1392.102094149268, 1402.7825687018324, 28419.43161136807, 30477.54283685791, 30934.381312374077, 31154.0, 31613.683863161074, 46853.0, 47167.76416117897, 47371.76314118407, 47477.28784068311, 47585.76207118942, 285924.0, 291005.0, 291145.0, 291577.0, 291827.0, 42081.78959105185, 42391.3641295387, 42761.786191068844, 43219.0, 43799.0, 39021.6097839018, 39637.20725585415, 39843.80078099591, 40233.396499053124, 40466.0, 36326.636733632324, 36390.09024774402, 36438.0, 36733.44899826451, 37196.25607487889, 35958.0, 36401.453978190875, 36744.26511469809, 36751.448728268566, 36826.26347472982, 38863.41704874373, 39040.6095939037, 39250.0, 39851.60148398595, 40216.0, 28868.855655721585, 28923.7107628921, 29850.0, 31034.68965310318, 31202.687973119977, 24822.0, 27997.234890117274, 28841.7115828839, 29090.0, 29375.85312073426], "unit": "score", "name": "ext.html", "value": 17858.273633195924}, {"lowerIsBetter": false, "replicates": [356.3727839003353, 358.8923323003098, 360.04049208858396, 360.9115766637174, 361.9131408461969, 16255.431059912906, 16354.754678679828, 16634.168291585433, 17188.96866188028, 17380.044097574628, 10975.670729878117, 10979.0, 15755.133467659274, 15857.60355991098, 15903.12532810695, 4811.182099043162, 5153.587712982952, 5330.093884039703, 5344.438833922441, 5373.220882971967, 5148.124818780816, 5237.47625237477, 5250.081235783741, 5440.483154100354, 5447.945520544803, 5074.695518268897, 5298.205269209611, 5439.918401223985, 5445.264889239961, 5463.180522921554, 5206.271122042898, 5214.504622060898, 5234.816781412632, 5248.973755131238, 5507.834764957058, 5263.947360526384, 5293.894122117536, 5304.973475132639, 5306.655067420644, 5314.707691076989, 11535.192536522447, 15910.840891591051, 18749.906250468797, 19461.902690486597, 19508.12213450398, 1988.8508361872773, 2022.2113375783456, 2055.8149766520937, 2075.4857440631313, 2109.535902101535, 9278.257739380833, 9597.040295970417, 9972.650957216463, 10696.572137114506, 12373.69065773354, 1795.3985414886029, 1822.362173239369, 1846.3722334406232, 1853.3328001919433, 1859.33064096925, 49316.26025609619, 50616.24075638905, 51885.0, 55531.44468555303, 56850.43149568493, 9249.630014799333, 9679.951600241953, 9832.360896541844, 9881.604735810632, 9968.35205711641, 12751.107422480338, 12813.103082784115, 12874.163179393498, 12897.161684490478, 12932.935335323264, 7309.597972111585, 7343.853122937511, 7355.190928997806, 7403.259674032662, 7471.364933980563, 7121.9643901780155, 7173.318534739192, 7184.0, 7217.819554511179, 7230.927690723131, 3975.344068228768, 4076.286649836267, 4085.305498065336, 4130.297849365615, 4146.274401979642, 1837.8939592089325, 1841.4383612998165, 1868.8136726880637, 1922.9326973555858, 1924.4419118455771, 415.1323733397214, 879.3273146043282, 909.1226965977863, 959.5538074795254, 1018.8471729240673, 10171.949140254252, 10427.009434103747, 10471.5272387095, 10798.622048228275, 10884.23810333285, 447.8096808856223, 464.1089108910899, 466.2493385649102, 473.9289106633964, 476.8831636249141, 4501.88745281364, 5933.1396947443245, 5987.850303742442, 6033.698315084228, 6058.515318774487, 539196.0, 543410.0, 544311.0, 549686.0, 559862.0, 37367.81316093402, 44781.77609111933, 53094.95597918192, 69793.3020669797, 71066.289337107, 486.44302273896193, 495.31646328067035, 498.44423467833104, 502.3946144895392, 502.7787773379701, 9723.56243969009, 9920.454375009444, 9963.750906227402, 10024.298299118991, 10105.9494702526, 28703.712962870104, 29879.850600746857, 30620.234494137825, 30658.693413066478, 30864.691353086182, 40267.19465610613, 40367.79816100901, 41087.38368924409, 41570.0, 41797.37303940504, 7115.146182458138, 7348.265173482609, 7413.332800048021, 7425.0, 7454.6645400956, 9139.954300228455, 10544.314619549705, 11086.501107450023, 11321.603743869255, 11375.772484550098, 9138.771530711785, 9367.344285900193, 9720.513974301115, 9758.365706229073, 9840.671509346146, 9354.95322523383, 9539.23686105096, 9737.464439455898, 9929.702108936743, 10246.6413675521, 9189.448633082036, 9304.860427093734, 9672.371295866027, 9692.515374231401, 10102.14131798776, 7346.96326518364, 7526.473146879885, 7535.585542795199, 7644.80887977805, 7656.464047516621, 8799.736007919773, 9190.586423611087, 9194.724158275263, 9277.16505514507, 9429.57566909477], "unit": "score", "name": "jquery.html", "value": 7318.3231656674625}, {"lowerIsBetter": false, "replicates": [1385.092764239423, 1402.7054318593096, 1561.515930061681, 1814.9291917768514, 1840.20871025459, 7710.0, 7778.5721785301785, 7891.60541972902, 7902.72340468083, 7957.801054973628, 7934.2065793420625, 7959.602019899011, 7972.1629228931, 8051.0, 8054.476459030159, 2336.0422226886935, 2346.6480027995767, 2349.0955981946986, 2349.9177528786495, 2364.798992085666, 2393.8204634652384, 2418.1415597462824, 2422.39440139965, 2426.9393265168424, 2428.2715185444385, 2332.486852892361, 2357.7170739511284, 2387.6537902004197, 2390.4501964548163, 2400.6399040143942, 2346.4485845826216, 2362.8936697848553, 2382.0471811275456, 2386.319898828834, 2392.6052201386665, 2408.494216214597, 2408.662787209792, 2425.7695518925852, 2430.2344761400104, 2438.305083051322, 7955.681772729084, 7990.12108668046, 8046.275835174863, 8078.27295543398, 8100.189981001853, 4871.853844384674, 4941.382327209099, 4962.62780291476, 4986.526280003394, 4990.675606085593, 3231.4991176367466, 3279.3769183854993, 3293.061477478907, 3342.715869151101, 3345.414552453311, 1031.3141760729106, 1036.533559898049, 1051.542578978147, 1082.967510974672, 1092.7213560542011, 10885.891141088567, 10977.12183025356, 11019.173561982883, 11045.061169800576, 11076.0, 4250.723702959298, 4309.870703878889, 4387.473503179639, 4399.318105693623, 4419.535948725402, 8884.0, 8896.377253592187, 8898.59956301968, 8902.955485222532, 8908.242799361997, 4786.545278198566, 4793.760311984456, 4798.664093513421, 4811.230203167476, 4830.66185367028, 4372.934405983913, 4395.7582332972, 4404.207242696281, 4428.33574963758, 4438.889027774331, 3414.334204830034, 3474.91312717179, 3488.0407887831047, 3519.788812671197, 3528.9294214115575, 1090.8527348807968, 1091.6233899304727, 1097.7694684116266, 1117.0505070689849, 1168.6201984355118, 1290.9289989050505, 1296.2546535741985, 1312.3044786263297, 1318.5978276625528, 1336.2917653643585, 7269.672864720995, 7271.527350722186, 7426.405887528985, 7449.14334851499, 7467.551946883204, 1130.1185075641013, 1140.1278022312938, 1148.8793676663997, 1154.786364522566, 1173.7065733566608, 5581.553475721932, 5722.341930678025, 5769.509591684669, 5795.275590551181, 5820.679862607597, 9079.18287354128, 9272.907270927204, 9408.106229908148, 9446.952765236267, 9477.336586439022, 9123.270138388913, 9206.158768246378, 9232.492212928219, 9273.768155796159, 9371.250299975985, 7490.400767938552, 7547.660355284025, 7584.355329797029, 7676.80807979805, 7711.0746710395115, 7314.0, 7321.670524826289, 7341.229170936975, 7371.668274927534, 7426.628668566658, 8074.878876816735, 8214.671413143646, 8280.668773249003, 8340.541270229953, 8511.616977236163, 8327.0, 8478.660853565789, 8486.787830304293, 8524.190201930807, 8537.359698022548, 6921.8961715575315, 6983.1620205575655, 7021.227664956953, 7030.156381234285, 7064.646767661699, 7220.638968051681, 7279.526830755984, 7299.5620262784405, 7315.926840731525, 7425.7029718810645, 6554.311797261219, 6949.131358580177, 7088.149422069178, 7092.25531319204, 7364.631768411451, 6968.442524597918, 6989.930100698928, 7018.5788852669, 7042.823929401806, 7073.6463176839925, 6818.181818181652, 6819.318068193339, 6836.0, 6872.381485666314, 6887.862242755217, 6276.4351208389635, 6290.559660823698, 6326.810195694136, 6404.551681382259, 6406.167198264196, 6395.872082558416, 6440.774572890114, 6461.289258181502, 6468.6442245676935, 6631.436327912182], "unit": "score", "name": "mootools.html", "value": 4572.097371175613}, {"lowerIsBetter": false, "replicates": [332.46141251173094, 338.71886334342497, 343.178088478095, 348.4511893767317, 349.58050339592495, 6165.8766824663535, 6223.782167624134, 6280.623162610246, 6300.243970723508, 6389.361063893608, 6205.844853878655, 6260.280067792205, 6264.653099583588, 6278.372162783719, 6280.214973128359, 4772.73749943753, 4779.0441911617645, 4786.856394308159, 4792.592629626477, 4795.0, 4755.072760811643, 4769.92676647755, 4774.641901857357, 4784.5693887550115, 4809.567138957493, 4661.044485880403, 4673.135469938055, 4687.92968105477, 4700.670953033289, 4704.97647511762, 4669.719816810985, 4670.509596492353, 4683.110209060268, 4688.64835137366, 4704.929426058612, 4025.19496100781, 4026.5369482509595, 4035.435039094529, 4057.3102572562734, 4065.4714887064492, 5941.9601569725555, 5943.465088142045, 5944.256967879015, 5952.226210592638, 5956.583039187259, 5308.601854860901, 5455.5908306877145, 5462.453754624506, 5478.342598888119, 5480.698561579112, 6595.878700620858, 6598.241202261754, 6607.273199948002, 6608.900866487006, 6617.834554136137, 4488.057507923308, 4492.61812745917, 4494.393256910308, 4497.325401189815, 4502.57225563571, 6766.086578311914, 6820.31796820319, 6887.242403335629, 6889.724411023603, 6899.517033807636, 4596.4254468191475, 4598.747068911175, 4604.930926036112, 4611.700239484423, 4614.192516309632, 4675.7895894684825, 4676.789544470507, 4679.27471241958, 4681.882952926204, 4697.929531057037, 5385.461453854661, 5426.158945363475, 5431.728413579305, 5442.0204363215, 5450.972745136249, 6506.934930650727, 6652.101966234593, 6660.83347916306, 6668.799936001928, 6690.5316627836555, 1624.2284914665677, 1644.9342026319052, 1671.156066186568, 1675.346614820221, 1678.3035040458074, 1091.8744344400495, 1092.9780655087518, 1097.5884043483693, 1100.301308669001, 1105.1269497097364, 6104.572679912363, 6116.908246376308, 6129.325774164839, 6158.476529494954, 6168.537359697951, 6617.239017512951, 6641.535092543476, 6654.13496245485, 6680.732770689216, 6687.431568316651, 6037.396260373927, 6125.601835880742, 6139.048447490646, 6139.079138129227, 6150.692465376803, 3654.2691461707764, 3656.067702735785, 3656.0859785053735, 3661.029827095822, 3666.4866918631415, 6992.93007069933, 7022.859542809115, 7033.085698859116, 7045.084139061889, 7051.153861536648, 6705.7652982146365, 6899.413549848319, 6903.896441553381, 6913.481488888253, 6919.619420931796, 6960.79117626472, 6997.650117494105, 7012.964935175291, 7013.4038606719005, 7017.403520700797, 6684.665766711742, 6697.732090716317, 6724.764633238009, 6729.158855143107, 6733.764318248838, 6506.41442270198, 6535.967320163369, 6575.901361479678, 6635.8009259722285, 6641.6422170130845, 7026.156861176487, 7028.262032486719, 7046.2249152594195, 7050.15398152225, 7052.894206586802, 4583.7249765012875, 4623.722576645412, 4633.606143477842, 4638.698484598491, 4641.837535686234, 6705.161854768154, 6749.9662501689145, 6754.2570317266045, 6775.186977562724, 6994.860102797814, 6706.228783689938, 6707.228668703162, 6746.392824645805, 6773.356531129535, 6774.966125169342, 6627.801165965029, 6649.268580456049, 6680.0, 6715.630640314829, 6732.764353247613, 6499.6425196612745, 6556.2788093310655, 6586.4401525870835, 6589.769358072444, 6593.175853018372, 6648.767293144911, 6699.933000670126, 6704.966475167593, 6707.5975441473665, 6725.226598940989, 6536.934630653633, 6559.704813283509, 6596.670166491752, 6621.106150669598, 6621.437177839937], "unit": "score", "name": "prototype.html", "value": 4948.469809469946}, {"lowerIsBetter": false, "replicates": [745.3143108340327, 767.543311729521, 807.7617102954628, 840.9957950210252, 867.618247970893, 12206.511739530419, 12511.999040076806, 12516.81224781629, 12548.184368016073, 12568.497260109596, 12091.214071085395, 12128.69678258044, 12132.090093242998, 12134.575289864857, 12167.391630418466, 798.0383637716552, 810.6109067647503, 828.772087675888, 831.1729828820332, 833.3333333333339, 814.722994181978, 814.8411059843332, 817.2113910076774, 817.7710241132493, 818.3657665309373, 851.7955690634266, 855.9400841941067, 855.9743207703779, 856.0027567883409, 857.8155696525246, 851.4891065360765, 851.5316575883239, 852.2968550945433, 852.6631980367752, 852.6631980367782, 629.1569297141806, 629.2291942370605, 630.1713247080075, 630.3696303696304, 634.9238091429058, 12905.741885162339, 12938.741225175443, 13043.413046412934, 13105.934470327587, 13117.540886069037, 11629.825552616718, 11706.122040846885, 11746.530138794438, 11784.646460606196, 12047.096467764954, 10063.949680251626, 10071.5467803949, 10307.639232626898, 10680.25238233324, 10928.0, 3532.8233588320736, 3621.6740493355724, 3641.253543023674, 3656.7988760618155, 3729.1050147964565, 42805.14389712188, 42825.0, 43027.569724302666, 43078.13843723139, 43445.782771086255, 8754.124587541195, 9122.589483473259, 9235.399699019543, 9315.813683726288, 9450.385724927857, 14987.625309367353, 15445.996010259298, 15511.146886921102, 15512.689746205238, 15518.456854010281, 7361.779146625609, 7392.519486233377, 7519.812004699927, 7586.924130758622, 7753.573553454501, 4360.672949528798, 4416.80124394403, 4424.889377765518, 4460.442444694413, 4464.15181115587, 2914.184028472031, 2919.357741296911, 2922.4885645012037, 2926.7365937065765, 2933.3546619743624, 539.5710410223803, 550.2983695787823, 567.234233784396, 567.7416775367197, 577.4946921443736, 513.9434662187157, 553.7646500237463, 606.4814583531106, 619.845038740315, 651.5927545284197, 7680.692772289046, 7785.385049463907, 7786.454948153688, 7849.764507064797, 7914.564698941614, 555.8554775758332, 594.6937327276456, 674.436845234235, 704.3449591879602, 746.2798399544465, 3766.3785475396253, 3936.193080418507, 3972.4835771350117, 4004.379321205218, 4011.959880401217, 53786.0, 53997.46002539925, 54155.104571340606, 54167.18749218765, 57658.7117064412, 48206.79483012883, 48542.271865921335, 48822.51177488251, 48867.511324887004, 49304.75347623239, 45067.098658026654, 45076.0, 45101.97041133222, 45592.772036139606, 45593.316100258526, 7682.961585192038, 7981.64082616272, 8055.436119471581, 8079.792555283072, 8179.222973817477, 33023.174420639676, 33202.0, 33353.499697505045, 33851.492227616116, 34057.318853623285, 38929.0, 39388.409173861844, 43190.0, 43242.56757432385, 43586.0, 9510.429374237568, 9581.520923953634, 9603.807923841623, 9718.465484398426, 9826.754331141492, 10684.83972740394, 10745.194110441904, 10807.405592692478, 10870.184736144663, 10977.835332470178, 9980.401175929177, 10293.53679084428, 10522.78954420892, 10579.15366770641, 10624.521896514521, 10298.742531436774, 10518.158547316349, 10522.210834187314, 10547.789044219226, 10554.841677374692, 9632.95183524078, 9949.095559474375, 10066.748331291483, 10145.442000690033, 10285.74285642865, 8589.914100858912, 8736.001918024445, 8790.296776257755, 8956.417832840845, 8982.236509896731, 8108.79728006781, 8130.349572034104, 8199.524419607586, 8445.535495547803, 9571.760705982128], "unit": "score", "name": "yui.html", "value": 5994.292692490428}], "name": "dromaeo_css", "value": 6729.999177955337}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 110.0, 112.0, 122.0, 112.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 152.0, 163.0, 125.0, 149.0, 154.0, 128.0, 170.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 164.0, 162.0, 164.0, 162.0, 163.0, 172.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 76.0, 72.0, 71.0, 71.0, 146.0, 73.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 149.0, 95.0, 96.0, 95.0, 136.0, 96.0, 95.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [99.0, 97.0, 97.0, 97.0, 97.0, 97.0, 98.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [61.0, 56.0, 58.0, 55.0, 59.0, 58.0, 55.0, 56.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 68.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 94.0, 86.0, 86.0, 85.0, 87.0, 87.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [119.0, 126.0, 126.0, 120.0, 122.0, 127.0, 120.0, 121.0, 125.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [144.0, 158.0, 156.0, 153.0, 156.0, 143.0, 155.0, 155.0, 155.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 67.0, 69.0, 70.0, 67.0, 74.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1521.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.44486108743823], "unit": "score", "name": "Richards", "value": 207.11683399999993}, {"lowerIsBetter": false, "replicates": [197.04433497536945], "unit": "score", "name": "DeltaBlue", "value": 335.54885000000013}, {"lowerIsBetter": false, "replicates": [283.68794326241135], "unit": "score", "name": "Encrypt", "value": 938.2880249999996}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [42354.166666666664], "unit": "score", "name": "RegExp", "value": 21.508745696015737}, {"lowerIsBetter": false, "replicates": [575.3739930955121], "unit": "score", "name": "Splay", "value": 141.631358}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20232.936076455215}]} 20:20:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20232.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1521.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6730.00"}}} 20:20:41 INFO - Return code: 0 20:20:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:41 INFO - # TBPL SUCCESS # 20:20:41 INFO - Running post-action listener: _resource_record_post_action 20:20:41 INFO - Running post-run listener: _resource_record_post_run 20:20:42 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 329121792; Read time: 44; Write time: 157700 20:20:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5566464; Read time: 0; Write time: 432 20:20:42 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 16384; Write bytes: 323555328; Read time: 44; Write time: 157268 20:20:42 INFO - Running post-run listener: _upload_blobber_files 20:20:42 INFO - Blob upload gear active. 20:20:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:20:42 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:20:42 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:20:42 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:20:43 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:43 INFO - (blobuploader) - INFO - Done attempting. 20:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:20:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:44 INFO - (blobuploader) - INFO - Done attempting. 20:20:44 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:44 INFO - Return code: 0 20:20:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:20:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae612cd3dda9c4b7378f4c9b9fe2a994fcec9ef0d4ff8d361a41de291baa8934f6b60c3fa8f2d4ad86dd546a31eb51851cdd50bc401ea4e87ae455b5eb1ebe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfe2977165baa336bbc555aa7b72453911c19bd00427a4ba38ad0b08611ba8d609fd7a9bad8b5e1d851c83ed9c381b0ff7c315ebe84dc0635fb192771417d8c"} 20:20:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:20:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:20:44 INFO - Contents: 20:20:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae612cd3dda9c4b7378f4c9b9fe2a994fcec9ef0d4ff8d361a41de291baa8934f6b60c3fa8f2d4ad86dd546a31eb51851cdd50bc401ea4e87ae455b5eb1ebe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfe2977165baa336bbc555aa7b72453911c19bd00427a4ba38ad0b08611ba8d609fd7a9bad8b5e1d851c83ed9c381b0ff7c315ebe84dc0635fb192771417d8c"} 20:20:44 INFO - Copying logs to upload dir... 20:20:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.851920 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-09 20:20:44.450984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:44.454415) ========= 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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae612cd3dda9c4b7378f4c9b9fe2a994fcec9ef0d4ff8d361a41de291baa8934f6b60c3fa8f2d4ad86dd546a31eb51851cdd50bc401ea4e87ae455b5eb1ebe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfe2977165baa336bbc555aa7b72453911c19bd00427a4ba38ad0b08611ba8d609fd7a9bad8b5e1d851c83ed9c381b0ff7c315ebe84dc0635fb192771417d8c"} build_url:https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ae612cd3dda9c4b7378f4c9b9fe2a994fcec9ef0d4ff8d361a41de291baa8934f6b60c3fa8f2d4ad86dd546a31eb51851cdd50bc401ea4e87ae455b5eb1ebe2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bfe2977165baa336bbc555aa7b72453911c19bd00427a4ba38ad0b08611ba8d609fd7a9bad8b5e1d851c83ed9c381b0ff7c315ebe84dc0635fb192771417d8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:44.487845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:44.488252) ========= 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=6dbc10da6d83fee962c624be000001a8-1452389397.541448-934989191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:44.541912) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 20:20:44.542254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 20:20:44.542584) ========= ========= Total master_lag: 0.26 =========